builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-024 starttime: 1473849864.81 results: success (0) buildid: 20160914004005 builduid: 6e063abc529a4e23ba2801ea66b534fc revision: 7852ac7e74faf5a637189437ce0a9a7f39e6292c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-14 03:44:24.810789) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-14 03:44:24.811256) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-14 03:44:24.811537) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-14 03:44:24.825991) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-14 03:44:24.826278) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41a7e32711b8e08598a63237000001d6-1473849864.248523-1632268604 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-14 03:44:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 217M=0s 2016-09-14 03:44:25 (217 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.123403 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-14 03:44:24.963739) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-14 03:44:24.964110) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41a7e32711b8e08598a63237000001d6-1473849864.248523-1632268604 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023841 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-14 03:44:25.013666) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-14 03:44:25.014020) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 7852ac7e74faf5a637189437ce0a9a7f39e6292c --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 7852ac7e74faf5a637189437ce0a9a7f39e6292c --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41a7e32711b8e08598a63237000001d6-1473849864.248523-1632268604 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-14 03:44:25,390 truncating revision to first 12 chars 2016-09-14 03:44:25,390 Setting DEBUG logging. 2016-09-14 03:44:25,390 attempt 1/10 2016-09-14 03:44:25,390 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/7852ac7e74fa?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-14 03:44:26,119 unpacking tar archive at: mozilla-aurora-7852ac7e74fa/testing/mozharness/ program finished with exit code 0 elapsedTime=1.054057 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-14 03:44:26.081463) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-14 03:44:26.081792) ========= script_repo_revision: 7852ac7e74faf5a637189437ce0a9a7f39e6292c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-14 03:44:26.082221) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-14 03:44:26.082492) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-14 03:44:26.092305) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 58 secs) (at 2016-09-14 03:44:26.092596) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41a7e32711b8e08598a63237000001d6-1473849864.248523-1632268604 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:44:26 INFO - MultiFileLogger online at 20160914 03:44:26 in /builds/slave/test 03:44:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:44:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:44:26 INFO - {'append_to_log': False, 03:44:26 INFO - 'base_work_dir': '/builds/slave/test', 03:44:26 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:44:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:44:26 INFO - 'branch': 'Mozilla-Aurora', 03:44:26 INFO - 'buildbot_json_path': 'buildprops.json', 03:44:26 INFO - 'config_files': ('talos/linux_config.py',), 03:44:26 INFO - 'default_actions': ('clobber', 03:44:26 INFO - 'read-buildbot-config', 03:44:26 INFO - 'download-and-extract', 03:44:26 INFO - 'populate-webroot', 03:44:26 INFO - 'create-virtualenv', 03:44:26 INFO - 'install', 03:44:26 INFO - 'run-tests'), 03:44:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:44:26 INFO - 'download_minidump_stackwalk': True, 03:44:26 INFO - 'download_symbols': 'ondemand', 03:44:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:44:26 INFO - 'tooltool.py': '/tools/tooltool.py', 03:44:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:44:26 INFO - '/tools/misc-python/virtualenv.py')}, 03:44:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:44:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:44:26 INFO - 'installer_path': 'installer.exe', 03:44:26 INFO - 'log_level': 'info', 03:44:26 INFO - 'log_name': 'talos', 03:44:26 INFO - 'log_to_console': True, 03:44:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:44:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:44:26 INFO - 'opt_config_files': (), 03:44:26 INFO - 'pip_index': False, 03:44:26 INFO - 'sps_profile': False, 03:44:26 INFO - 'sps_profile_interval': 0, 03:44:26 INFO - 'suite': 'dromaeojs-e10s', 03:44:26 INFO - 'system_bits': '32', 03:44:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:44:26 INFO - 'title': 'talos-linux64-ix-024', 03:44:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:44:26 INFO - 'use_talos_json': True, 03:44:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:44:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:44:26 INFO - 'work_dir': 'build'} 03:44:26 INFO - [mozharness: 2016-09-14 10:44:26.566298Z] Running clobber step. 03:44:26 INFO - Running pre-action listener: _resource_record_pre_action 03:44:26 INFO - Running main action method: clobber 03:44:26 INFO - rmtree: /builds/slave/test/build 03:44:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:44:27 INFO - Running post-action listener: _resource_record_post_action 03:44:27 INFO - [mozharness: 2016-09-14 10:44:27.024998Z] Finished clobber step (success) 03:44:27 INFO - [mozharness: 2016-09-14 10:44:27.025100Z] Running read-buildbot-config step. 03:44:27 INFO - Running pre-action listener: _resource_record_pre_action 03:44:27 INFO - Running main action method: read_buildbot_config 03:44:27 INFO - Using buildbot properties: 03:44:27 INFO - { 03:44:27 INFO - "project": "", 03:44:27 INFO - "product": "firefox", 03:44:27 INFO - "script_repo_revision": "production", 03:44:27 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 03:44:27 INFO - "repository": "", 03:44:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 03:44:27 INFO - "buildid": "20160914004005", 03:44:27 INFO - "stage_platform": "linux64-pgo", 03:44:27 INFO - "basedir": "/builds/slave/test", 03:44:27 INFO - "nightly_build": "True", 03:44:27 INFO - "buildnumber": 503, 03:44:27 INFO - "slavename": "talos-linux64-ix-024", 03:44:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:44:27 INFO - "platform": "ubuntu64_hw", 03:44:27 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:44:27 INFO - "branch": "mozilla-aurora", 03:44:27 INFO - "repo_path": "releases/mozilla-aurora", 03:44:27 INFO - "revision": "7852ac7e74faf5a637189437ce0a9a7f39e6292c", 03:44:27 INFO - "pgo_build": "True", 03:44:27 INFO - "builduid": "6e063abc529a4e23ba2801ea66b534fc", 03:44:27 INFO - "slavebuilddir": "test" 03:44:27 INFO - } 03:44:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/Rp6e7ySwSWqdPvDsHr_9Jg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2. 03:44:27 INFO - Running post-action listener: _resource_record_post_action 03:44:27 INFO - [mozharness: 2016-09-14 10:44:27.027646Z] Finished read-buildbot-config step (success) 03:44:27 INFO - [mozharness: 2016-09-14 10:44:27.027736Z] Running download-and-extract step. 03:44:27 INFO - Running pre-action listener: _resource_record_pre_action 03:44:27 INFO - Running main action method: download_and_extract 03:44:27 INFO - mkdir: /builds/slave/test/build/tests 03:44:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:44:27 INFO - https://queue.taskcluster.net/v1/task/Rp6e7ySwSWqdPvDsHr_9Jg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:44:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rp6e7ySwSWqdPvDsHr_9Jg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:44:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rp6e7ySwSWqdPvDsHr_9Jg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:44:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rp6e7ySwSWqdPvDsHr_9Jg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:44:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rp6e7ySwSWqdPvDsHr_9Jg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:44:27 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rp6e7ySwSWqdPvDsHr_9Jg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:44:27 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:44:27 INFO - retry: Failed, sleeping 30 seconds before retrying 03:44:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rp6e7ySwSWqdPvDsHr_9Jg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #2 03:44:57 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rp6e7ySwSWqdPvDsHr_9Jg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:44:57 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:44:57 INFO - retry: Failed, sleeping 60 seconds before retrying 03:45:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rp6e7ySwSWqdPvDsHr_9Jg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #3 03:45:57 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rp6e7ySwSWqdPvDsHr_9Jg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:45:57 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:45:57 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rp6e7ySwSWqdPvDsHr_9Jg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json! 03:45:57 INFO - Caught exception: HTTP Error 404: Not Found 03:45:57 INFO - Caught exception: HTTP Error 404: Not Found 03:45:57 INFO - Caught exception: HTTP Error 404: Not Found 03:45:57 INFO - trying https://queue.taskcluster.net/v1/task/Rp6e7ySwSWqdPvDsHr_9Jg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:45:57 INFO - Downloading https://queue.taskcluster.net/v1/task/Rp6e7ySwSWqdPvDsHr_9Jg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:45:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Rp6e7ySwSWqdPvDsHr_9Jg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:45:57 INFO - Downloaded 1361 bytes. 03:45:57 INFO - Reading from file /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:45:57 INFO - Using the following test package requirements: 03:45:57 INFO - {u'common': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 03:45:57 INFO - u'cppunittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:45:57 INFO - u'firefox-50.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:45:57 INFO - u'gtest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:45:57 INFO - u'firefox-50.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:45:57 INFO - u'jittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:45:57 INFO - u'jsshell-linux-x86_64.zip'], 03:45:57 INFO - u'mochitest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:45:57 INFO - u'firefox-50.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:45:57 INFO - u'mozbase': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 03:45:57 INFO - u'reftest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:45:57 INFO - u'firefox-50.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:45:57 INFO - u'talos': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:45:57 INFO - u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:45:57 INFO - u'web-platform': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:45:57 INFO - u'firefox-50.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:45:57 INFO - u'xpcshell': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:45:57 INFO - u'firefox-50.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:45:57 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:45:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:45:57 INFO - https://queue.taskcluster.net/v1/task/Rp6e7ySwSWqdPvDsHr_9Jg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:45:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rp6e7ySwSWqdPvDsHr_9Jg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:45:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rp6e7ySwSWqdPvDsHr_9Jg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:45:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rp6e7ySwSWqdPvDsHr_9Jg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:45:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rp6e7ySwSWqdPvDsHr_9Jg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:45:57 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rp6e7ySwSWqdPvDsHr_9Jg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:45:57 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:45:57 INFO - retry: Failed, sleeping 30 seconds before retrying 03:46:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rp6e7ySwSWqdPvDsHr_9Jg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #2 03:46:27 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rp6e7ySwSWqdPvDsHr_9Jg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:46:27 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:46:27 INFO - retry: Failed, sleeping 60 seconds before retrying 03:47:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rp6e7ySwSWqdPvDsHr_9Jg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #3 03:47:27 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rp6e7ySwSWqdPvDsHr_9Jg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:47:27 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:47:27 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rp6e7ySwSWqdPvDsHr_9Jg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip! 03:47:27 INFO - Caught exception: HTTP Error 404: Not Found 03:47:27 INFO - Caught exception: HTTP Error 404: Not Found 03:47:27 INFO - Caught exception: HTTP Error 404: Not Found 03:47:27 INFO - trying https://queue.taskcluster.net/v1/task/Rp6e7ySwSWqdPvDsHr_9Jg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:47:27 INFO - Downloading https://queue.taskcluster.net/v1/task/Rp6e7ySwSWqdPvDsHr_9Jg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:47:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Rp6e7ySwSWqdPvDsHr_9Jg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:47:28 INFO - Downloaded 21772186 bytes. 03:47:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:47:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:47:29 INFO - Return code: 0 03:47:29 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:47:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:47:29 INFO - https://queue.taskcluster.net/v1/task/Rp6e7ySwSWqdPvDsHr_9Jg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:47:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rp6e7ySwSWqdPvDsHr_9Jg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:47:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rp6e7ySwSWqdPvDsHr_9Jg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:47:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rp6e7ySwSWqdPvDsHr_9Jg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:47:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rp6e7ySwSWqdPvDsHr_9Jg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:47:29 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rp6e7ySwSWqdPvDsHr_9Jg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:47:29 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:47:29 INFO - retry: Failed, sleeping 30 seconds before retrying 03:47:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rp6e7ySwSWqdPvDsHr_9Jg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #2 03:47:59 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rp6e7ySwSWqdPvDsHr_9Jg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:47:59 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:47:59 INFO - retry: Failed, sleeping 60 seconds before retrying 03:48:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rp6e7ySwSWqdPvDsHr_9Jg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #3 03:48:59 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rp6e7ySwSWqdPvDsHr_9Jg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:48:59 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:48:59 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rp6e7ySwSWqdPvDsHr_9Jg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip! 03:48:59 INFO - Caught exception: HTTP Error 404: Not Found 03:48:59 INFO - Caught exception: HTTP Error 404: Not Found 03:48:59 INFO - Caught exception: HTTP Error 404: Not Found 03:48:59 INFO - trying https://queue.taskcluster.net/v1/task/Rp6e7ySwSWqdPvDsHr_9Jg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:48:59 INFO - Downloading https://queue.taskcluster.net/v1/task/Rp6e7ySwSWqdPvDsHr_9Jg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:48:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Rp6e7ySwSWqdPvDsHr_9Jg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:49:00 INFO - Downloaded 21772186 bytes. 03:49:00 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:49:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:49:02 INFO - Return code: 0 03:49:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:49:02 INFO - https://queue.taskcluster.net/v1/task/Rp6e7ySwSWqdPvDsHr_9Jg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:49:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rp6e7ySwSWqdPvDsHr_9Jg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:49:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rp6e7ySwSWqdPvDsHr_9Jg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:49:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rp6e7ySwSWqdPvDsHr_9Jg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:49:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rp6e7ySwSWqdPvDsHr_9Jg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:49:02 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rp6e7ySwSWqdPvDsHr_9Jg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:49:02 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:49:02 INFO - retry: Failed, sleeping 30 seconds before retrying 03:49:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rp6e7ySwSWqdPvDsHr_9Jg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #2 03:49:32 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rp6e7ySwSWqdPvDsHr_9Jg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:49:32 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:49:32 INFO - retry: Failed, sleeping 60 seconds before retrying 03:50:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rp6e7ySwSWqdPvDsHr_9Jg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #3 03:50:32 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rp6e7ySwSWqdPvDsHr_9Jg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:50:32 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:50:32 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rp6e7ySwSWqdPvDsHr_9Jg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip! 03:50:32 INFO - Caught exception: HTTP Error 404: Not Found 03:50:32 INFO - Caught exception: HTTP Error 404: Not Found 03:50:32 INFO - Caught exception: HTTP Error 404: Not Found 03:50:32 INFO - trying https://queue.taskcluster.net/v1/task/Rp6e7ySwSWqdPvDsHr_9Jg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:50:32 INFO - Downloading https://queue.taskcluster.net/v1/task/Rp6e7ySwSWqdPvDsHr_9Jg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:50:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Rp6e7ySwSWqdPvDsHr_9Jg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:50:33 INFO - Downloaded 14413740 bytes. 03:50:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:50:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 03:50:33 INFO - Return code: 0 03:50:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:50:33 INFO - https://queue.taskcluster.net/v1/task/Rp6e7ySwSWqdPvDsHr_9Jg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:50:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rp6e7ySwSWqdPvDsHr_9Jg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:50:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rp6e7ySwSWqdPvDsHr_9Jg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:50:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rp6e7ySwSWqdPvDsHr_9Jg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:50:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rp6e7ySwSWqdPvDsHr_9Jg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:50:33 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rp6e7ySwSWqdPvDsHr_9Jg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:50:33 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:50:33 INFO - retry: Failed, sleeping 30 seconds before retrying 03:51:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rp6e7ySwSWqdPvDsHr_9Jg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #2 03:51:03 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rp6e7ySwSWqdPvDsHr_9Jg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:51:03 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:51:03 INFO - retry: Failed, sleeping 60 seconds before retrying 03:52:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rp6e7ySwSWqdPvDsHr_9Jg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #3 03:52:03 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rp6e7ySwSWqdPvDsHr_9Jg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:52:03 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:52:03 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rp6e7ySwSWqdPvDsHr_9Jg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2! 03:52:03 INFO - Caught exception: HTTP Error 404: Not Found 03:52:03 INFO - Caught exception: HTTP Error 404: Not Found 03:52:03 INFO - Caught exception: HTTP Error 404: Not Found 03:52:03 INFO - trying https://queue.taskcluster.net/v1/task/Rp6e7ySwSWqdPvDsHr_9Jg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:52:03 INFO - Downloading https://queue.taskcluster.net/v1/task/Rp6e7ySwSWqdPvDsHr_9Jg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:52:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Rp6e7ySwSWqdPvDsHr_9Jg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:52:04 INFO - Downloaded 63889049 bytes. 03:52:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Rp6e7ySwSWqdPvDsHr_9Jg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:52:04 INFO - mkdir: /builds/slave/test/properties 03:52:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:52:04 INFO - Writing to file /builds/slave/test/properties/build_url 03:52:04 INFO - Contents: 03:52:04 INFO - build_url:https://queue.taskcluster.net/v1/task/Rp6e7ySwSWqdPvDsHr_9Jg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:52:05 INFO - Running post-action listener: _resource_record_post_action 03:52:05 INFO - Running post-action listener: set_extra_try_arguments 03:52:05 INFO - [mozharness: 2016-09-14 10:52:05.242744Z] Finished download-and-extract step (success) 03:52:05 INFO - [mozharness: 2016-09-14 10:52:05.242979Z] Running populate-webroot step. 03:52:05 INFO - Running pre-action listener: _resource_record_pre_action 03:52:05 INFO - Running main action method: populate_webroot 03:52:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:52:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:52:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:52:05 INFO - '--tppagecycles', 03:52:05 INFO - '7'], 03:52:05 INFO - 'tests': ['tsvgm']}}, 03:52:05 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:52:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:52:05 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:52:05 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:52:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:52:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:52:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:52:05 INFO - 'talos_options': ['--disable-e10s'], 03:52:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:52:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:52:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:52:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:52:05 INFO - 'talos_options': ['--disable-e10s'], 03:52:05 INFO - 'tests': ['damp', 'tps']}, 03:52:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:52:05 INFO - 'tests': ['damp', 'tps']}, 03:52:05 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:52:05 INFO - 'tests': ['dromaeo_dom']}, 03:52:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:52:05 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:52:05 INFO - 'tests': ['basic_compositor_video']}, 03:52:05 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:52:05 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:52:05 INFO - 'tests': ['a11yr', 03:52:05 INFO - 'ts_paint', 03:52:05 INFO - 'tpaint', 03:52:05 INFO - 'sessionrestore', 03:52:05 INFO - 'sessionrestore_no_auto_restore', 03:52:05 INFO - 'tabpaint']}, 03:52:05 INFO - 'other-e10s': {'tests': ['a11yr', 03:52:05 INFO - 'ts_paint', 03:52:05 INFO - 'tpaint', 03:52:05 INFO - 'sessionrestore', 03:52:05 INFO - 'sessionrestore_no_auto_restore', 03:52:05 INFO - 'tabpaint']}, 03:52:05 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:52:05 INFO - 'ts_paint', 03:52:05 INFO - 'tpaint', 03:52:05 INFO - 'sessionrestore', 03:52:05 INFO - 'sessionrestore_no_auto_restore', 03:52:05 INFO - 'tabpaint']}, 03:52:05 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:52:05 INFO - 'ts_paint', 03:52:05 INFO - 'tpaint', 03:52:05 INFO - 'sessionrestore', 03:52:05 INFO - 'sessionrestore_no_auto_restore', 03:52:05 INFO - 'tabpaint']}, 03:52:05 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:52:05 INFO - 'tests': ['a11yr', 03:52:05 INFO - 'ts_paint', 03:52:05 INFO - 'tpaint', 03:52:05 INFO - 'sessionrestore', 03:52:05 INFO - 'sessionrestore_no_auto_restore', 03:52:05 INFO - 'tabpaint']}, 03:52:05 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:52:05 INFO - 'tests': ['a11yr', 03:52:05 INFO - 'ts_paint', 03:52:05 INFO - 'tpaint', 03:52:05 INFO - 'sessionrestore', 03:52:05 INFO - 'sessionrestore_no_auto_restore', 03:52:05 INFO - 'tabpaint']}, 03:52:05 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:52:05 INFO - 'tests': ['tsvgx', 03:52:05 INFO - 'tsvgr_opacity', 03:52:05 INFO - 'tart', 03:52:05 INFO - 'tscrollx', 03:52:05 INFO - 'cart']}, 03:52:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:52:05 INFO - 'tsvgr_opacity', 03:52:05 INFO - 'tart', 03:52:05 INFO - 'tscrollx', 03:52:05 INFO - 'cart']}, 03:52:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:52:05 INFO - 'talos_options': ['--disable-e10s'], 03:52:05 INFO - 'tests': ['tp5o']}, 03:52:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:52:05 INFO - 'tests': ['tp5o']}, 03:52:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:52:05 INFO - 'talos_options': ['--disable-e10s', 03:52:05 INFO - '--xperf_path', 03:52:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:52:05 INFO - 'tests': ['tp5n']}, 03:52:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:52:05 INFO - 'talos_options': ['--xperf_path', 03:52:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:52:05 INFO - 'tests': ['tp5n']}}, 03:52:05 INFO - 'talos.zip': {'path': '', 03:52:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:52:05 INFO - Running post-action listener: _resource_record_post_action 03:52:05 INFO - [mozharness: 2016-09-14 10:52:05.263146Z] Finished populate-webroot step (success) 03:52:05 INFO - [mozharness: 2016-09-14 10:52:05.263236Z] Running create-virtualenv step. 03:52:05 INFO - Running pre-action listener: _resource_record_pre_action 03:52:05 INFO - Running main action method: create_virtualenv 03:52:05 INFO - Creating virtualenv /builds/slave/test/build/venv 03:52:05 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:52:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:52:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:52:05 INFO - Using real prefix '/usr' 03:52:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:52:05 INFO - Installing distribute.............................................................................................................................................................................................done. 03:52:07 INFO - Installing pip.................done. 03:52:07 INFO - Return code: 0 03:52:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:52:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:52:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:52:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x298a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aed8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bb9400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c48570>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c49470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c49900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1473849864.248523-1632268604', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:52:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:52:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:52:07 INFO - Using env: {'DISPLAY': ':0', 03:52:07 INFO - 'HOME': '/home/cltbld', 03:52:07 INFO - 'LANG': 'en_US.UTF-8', 03:52:07 INFO - 'LANGUAGE': 'en_US:en', 03:52:07 INFO - 'LOGNAME': 'cltbld', 03:52:07 INFO - 'MAIL': '/var/mail/cltbld', 03:52:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:07 INFO - 'MOZ_NO_REMOTE': '1', 03:52:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:07 INFO - 'NO_EM_RESTART': '1', 03:52:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:07 INFO - 'PWD': '/builds/slave/test', 03:52:07 INFO - 'SHELL': '/bin/bash', 03:52:07 INFO - 'SHLVL': '1', 03:52:07 INFO - 'TERM': 'linux', 03:52:07 INFO - 'TMOUT': '86400', 03:52:07 INFO - 'USER': 'cltbld', 03:52:07 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1473849864.248523-1632268604', 03:52:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:07 INFO - '_': '/tools/buildbot/bin/python'} 03:52:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:08 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:52:08 INFO - Cleaning up... 03:52:08 INFO - Return code: 0 03:52:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:52:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:52:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:52:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x298a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aed8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bb9400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c48570>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c49470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c49900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1473849864.248523-1632268604', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:52:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:52:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:52:08 INFO - Using env: {'DISPLAY': ':0', 03:52:08 INFO - 'HOME': '/home/cltbld', 03:52:08 INFO - 'LANG': 'en_US.UTF-8', 03:52:08 INFO - 'LANGUAGE': 'en_US:en', 03:52:08 INFO - 'LOGNAME': 'cltbld', 03:52:08 INFO - 'MAIL': '/var/mail/cltbld', 03:52:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:08 INFO - 'MOZ_NO_REMOTE': '1', 03:52:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:08 INFO - 'NO_EM_RESTART': '1', 03:52:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:08 INFO - 'PWD': '/builds/slave/test', 03:52:08 INFO - 'SHELL': '/bin/bash', 03:52:08 INFO - 'SHLVL': '1', 03:52:08 INFO - 'TERM': 'linux', 03:52:08 INFO - 'TMOUT': '86400', 03:52:08 INFO - 'USER': 'cltbld', 03:52:08 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1473849864.248523-1632268604', 03:52:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:08 INFO - '_': '/tools/buildbot/bin/python'} 03:52:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:08 INFO - Downloading/unpacking psutil>=3.1.1 03:52:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:52:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:52:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:52:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:52:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:52:10 INFO - Installing collected packages: psutil 03:52:10 INFO - Running setup.py install for psutil 03:52:10 INFO - building 'psutil._psutil_linux' extension 03:52:10 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:52:10 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:52:10 INFO - building 'psutil._psutil_posix' extension 03:52:10 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:52:10 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:52:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:52:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:52:10 INFO - Successfully installed psutil 03:52:10 INFO - Cleaning up... 03:52:10 INFO - Return code: 0 03:52:10 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:52:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:52:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:52:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x298a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aed8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bb9400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c48570>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c49470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c49900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1473849864.248523-1632268604', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:52:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:52:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:52:10 INFO - Using env: {'DISPLAY': ':0', 03:52:10 INFO - 'HOME': '/home/cltbld', 03:52:10 INFO - 'LANG': 'en_US.UTF-8', 03:52:10 INFO - 'LANGUAGE': 'en_US:en', 03:52:10 INFO - 'LOGNAME': 'cltbld', 03:52:10 INFO - 'MAIL': '/var/mail/cltbld', 03:52:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:10 INFO - 'MOZ_NO_REMOTE': '1', 03:52:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:10 INFO - 'NO_EM_RESTART': '1', 03:52:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:10 INFO - 'PWD': '/builds/slave/test', 03:52:10 INFO - 'SHELL': '/bin/bash', 03:52:10 INFO - 'SHLVL': '1', 03:52:10 INFO - 'TERM': 'linux', 03:52:10 INFO - 'TMOUT': '86400', 03:52:10 INFO - 'USER': 'cltbld', 03:52:10 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1473849864.248523-1632268604', 03:52:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:10 INFO - '_': '/tools/buildbot/bin/python'} 03:52:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:11 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:52:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:52:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:52:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:13 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:52:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:52:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:52:13 INFO - Installing collected packages: mozsystemmonitor 03:52:13 INFO - Running setup.py install for mozsystemmonitor 03:52:13 INFO - Successfully installed mozsystemmonitor 03:52:13 INFO - Cleaning up... 03:52:13 INFO - Return code: 0 03:52:13 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:52:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:52:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:52:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x298a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aed8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bb9400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c48570>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c49470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c49900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1473849864.248523-1632268604', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:52:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:52:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:52:13 INFO - Using env: {'DISPLAY': ':0', 03:52:13 INFO - 'HOME': '/home/cltbld', 03:52:13 INFO - 'LANG': 'en_US.UTF-8', 03:52:13 INFO - 'LANGUAGE': 'en_US:en', 03:52:13 INFO - 'LOGNAME': 'cltbld', 03:52:13 INFO - 'MAIL': '/var/mail/cltbld', 03:52:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:13 INFO - 'MOZ_NO_REMOTE': '1', 03:52:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:13 INFO - 'NO_EM_RESTART': '1', 03:52:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:13 INFO - 'PWD': '/builds/slave/test', 03:52:13 INFO - 'SHELL': '/bin/bash', 03:52:13 INFO - 'SHLVL': '1', 03:52:13 INFO - 'TERM': 'linux', 03:52:13 INFO - 'TMOUT': '86400', 03:52:13 INFO - 'USER': 'cltbld', 03:52:13 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1473849864.248523-1632268604', 03:52:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:13 INFO - '_': '/tools/buildbot/bin/python'} 03:52:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:13 INFO - Downloading/unpacking jsonschema==2.5.1 03:52:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:52:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:52:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:52:15 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:52:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:52:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:52:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:15 INFO - Downloading functools32-3.2.3-2.tar.gz 03:52:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:52:15 INFO - warning: no files found matching '*.txt' 03:52:15 INFO - no previously-included directories found matching 'build' 03:52:15 INFO - no previously-included directories found matching 'dist' 03:52:15 INFO - no previously-included directories found matching '.git*' 03:52:15 INFO - Installing collected packages: jsonschema, functools32 03:52:15 INFO - Running setup.py install for functools32 03:52:15 INFO - warning: no files found matching '*.txt' 03:52:15 INFO - no previously-included directories found matching 'build' 03:52:15 INFO - no previously-included directories found matching 'dist' 03:52:15 INFO - no previously-included directories found matching '.git*' 03:52:15 INFO - Successfully installed jsonschema functools32 03:52:15 INFO - Cleaning up... 03:52:16 INFO - Return code: 0 03:52:16 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:52:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:52:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:52:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x298a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aed8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bb9400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c48570>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c49470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c49900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1473849864.248523-1632268604', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:52:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:52:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:52:16 INFO - Using env: {'DISPLAY': ':0', 03:52:16 INFO - 'HOME': '/home/cltbld', 03:52:16 INFO - 'LANG': 'en_US.UTF-8', 03:52:16 INFO - 'LANGUAGE': 'en_US:en', 03:52:16 INFO - 'LOGNAME': 'cltbld', 03:52:16 INFO - 'MAIL': '/var/mail/cltbld', 03:52:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:16 INFO - 'MOZ_NO_REMOTE': '1', 03:52:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:16 INFO - 'NO_EM_RESTART': '1', 03:52:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:16 INFO - 'PWD': '/builds/slave/test', 03:52:16 INFO - 'SHELL': '/bin/bash', 03:52:16 INFO - 'SHLVL': '1', 03:52:16 INFO - 'TERM': 'linux', 03:52:16 INFO - 'TMOUT': '86400', 03:52:16 INFO - 'USER': 'cltbld', 03:52:16 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1473849864.248523-1632268604', 03:52:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:16 INFO - '_': '/tools/buildbot/bin/python'} 03:52:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:16 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:52:16 INFO - Cleaning up... 03:52:16 INFO - Return code: 0 03:52:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:52:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:52:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:52:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x298a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aed8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bb9400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c48570>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c49470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c49900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1473849864.248523-1632268604', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:52:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:52:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:52:16 INFO - Using env: {'DISPLAY': ':0', 03:52:16 INFO - 'HOME': '/home/cltbld', 03:52:16 INFO - 'LANG': 'en_US.UTF-8', 03:52:16 INFO - 'LANGUAGE': 'en_US:en', 03:52:16 INFO - 'LOGNAME': 'cltbld', 03:52:16 INFO - 'MAIL': '/var/mail/cltbld', 03:52:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:16 INFO - 'MOZ_NO_REMOTE': '1', 03:52:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:16 INFO - 'NO_EM_RESTART': '1', 03:52:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:16 INFO - 'PWD': '/builds/slave/test', 03:52:16 INFO - 'SHELL': '/bin/bash', 03:52:16 INFO - 'SHLVL': '1', 03:52:16 INFO - 'TERM': 'linux', 03:52:16 INFO - 'TMOUT': '86400', 03:52:16 INFO - 'USER': 'cltbld', 03:52:16 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1473849864.248523-1632268604', 03:52:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:16 INFO - '_': '/tools/buildbot/bin/python'} 03:52:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:16 INFO - Downloading/unpacking blobuploader==1.2.4 03:52:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:52:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:52:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:18 INFO - Downloading blobuploader-1.2.4.tar.gz 03:52:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:52:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:52:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:52:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:52:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:52:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:52:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:52:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:52:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:19 INFO - Downloading docopt-0.6.1.tar.gz 03:52:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:52:19 INFO - Installing collected packages: blobuploader, requests, docopt 03:52:19 INFO - Running setup.py install for blobuploader 03:52:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:52:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:52:19 INFO - Running setup.py install for requests 03:52:19 INFO - Running setup.py install for docopt 03:52:19 INFO - Successfully installed blobuploader requests docopt 03:52:19 INFO - Cleaning up... 03:52:19 INFO - Return code: 0 03:52:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:52:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:52:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:52:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x298a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aed8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bb9400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c48570>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c49470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c49900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1473849864.248523-1632268604', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:52:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:52:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:52:19 INFO - Using env: {'DISPLAY': ':0', 03:52:19 INFO - 'HOME': '/home/cltbld', 03:52:19 INFO - 'LANG': 'en_US.UTF-8', 03:52:19 INFO - 'LANGUAGE': 'en_US:en', 03:52:19 INFO - 'LOGNAME': 'cltbld', 03:52:19 INFO - 'MAIL': '/var/mail/cltbld', 03:52:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:19 INFO - 'MOZ_NO_REMOTE': '1', 03:52:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:19 INFO - 'NO_EM_RESTART': '1', 03:52:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:19 INFO - 'PWD': '/builds/slave/test', 03:52:19 INFO - 'SHELL': '/bin/bash', 03:52:19 INFO - 'SHLVL': '1', 03:52:19 INFO - 'TERM': 'linux', 03:52:19 INFO - 'TMOUT': '86400', 03:52:19 INFO - 'USER': 'cltbld', 03:52:19 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1473849864.248523-1632268604', 03:52:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:19 INFO - '_': '/tools/buildbot/bin/python'} 03:52:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:52:19 INFO - Running setup.py (path:/tmp/pip-kFk79N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:52:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:52:20 INFO - Running setup.py (path:/tmp/pip-pdHraI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:52:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:52:20 INFO - Running setup.py (path:/tmp/pip-Q3bCkv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:52:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:52:20 INFO - Running setup.py (path:/tmp/pip-xdwr4p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:52:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:52:20 INFO - Running setup.py (path:/tmp/pip-7gccYH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:52:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:52:20 INFO - Running setup.py (path:/tmp/pip-oEPjIH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:52:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:52:20 INFO - Running setup.py (path:/tmp/pip-OlWL11-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:52:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:52:20 INFO - Running setup.py (path:/tmp/pip-Fx6KWD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:52:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:52:20 INFO - Running setup.py (path:/tmp/pip-Z7DmQX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:52:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:52:20 INFO - Running setup.py (path:/tmp/pip-SREIyG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:52:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:52:20 INFO - Running setup.py (path:/tmp/pip-_02k1B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:52:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:52:20 INFO - Running setup.py (path:/tmp/pip-mxjJUZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:52:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:52:20 INFO - Running setup.py (path:/tmp/pip-qTBdvb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:52:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:52:20 INFO - Running setup.py (path:/tmp/pip-GzhTFx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:52:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:52:20 INFO - Running setup.py (path:/tmp/pip-aMBibW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:52:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:52:21 INFO - Running setup.py (path:/tmp/pip-8im7te-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:52:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:52:21 INFO - Running setup.py (path:/tmp/pip-sKsXAS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:52:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:52:21 INFO - Running setup.py install for manifestparser 03:52:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:52:21 INFO - Running setup.py install for mozcrash 03:52:21 INFO - Running setup.py install for mozdebug 03:52:21 INFO - Running setup.py install for mozdevice 03:52:21 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:52:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:52:21 INFO - Running setup.py install for mozfile 03:52:21 INFO - Running setup.py install for mozhttpd 03:52:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:52:21 INFO - Running setup.py install for mozinfo 03:52:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:52:21 INFO - Running setup.py install for mozInstall 03:52:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:52:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:52:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:52:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:52:21 INFO - Running setup.py install for mozleak 03:52:22 INFO - Running setup.py install for mozlog 03:52:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:52:22 INFO - Running setup.py install for moznetwork 03:52:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:52:22 INFO - Running setup.py install for mozprocess 03:52:22 INFO - Running setup.py install for mozprofile 03:52:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:52:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:52:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:52:22 INFO - Running setup.py install for mozrunner 03:52:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:52:22 INFO - Running setup.py install for mozscreenshot 03:52:22 INFO - Running setup.py install for moztest 03:52:22 INFO - Running setup.py install for mozversion 03:52:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:52:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:52:22 INFO - Cleaning up... 03:52:22 INFO - Return code: 0 03:52:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:52:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:52:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:52:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x298a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aed8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bb9400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c48570>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c49470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c49900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1473849864.248523-1632268604', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:52:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:52:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:52:23 INFO - Using env: {'DISPLAY': ':0', 03:52:23 INFO - 'HOME': '/home/cltbld', 03:52:23 INFO - 'LANG': 'en_US.UTF-8', 03:52:23 INFO - 'LANGUAGE': 'en_US:en', 03:52:23 INFO - 'LOGNAME': 'cltbld', 03:52:23 INFO - 'MAIL': '/var/mail/cltbld', 03:52:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:23 INFO - 'MOZ_NO_REMOTE': '1', 03:52:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:23 INFO - 'NO_EM_RESTART': '1', 03:52:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:23 INFO - 'PWD': '/builds/slave/test', 03:52:23 INFO - 'SHELL': '/bin/bash', 03:52:23 INFO - 'SHLVL': '1', 03:52:23 INFO - 'TERM': 'linux', 03:52:23 INFO - 'TMOUT': '86400', 03:52:23 INFO - 'USER': 'cltbld', 03:52:23 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1473849864.248523-1632268604', 03:52:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:23 INFO - '_': '/tools/buildbot/bin/python'} 03:52:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:52:23 INFO - Running setup.py (path:/tmp/pip-n1AxDI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:52:23 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:52:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:52:23 INFO - Running setup.py (path:/tmp/pip-KrwKmW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:52:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:52:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:52:23 INFO - Running setup.py (path:/tmp/pip-oN5lAU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:52:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:52:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:52:23 INFO - Running setup.py (path:/tmp/pip-oO0taH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:52:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:52:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:52:23 INFO - Running setup.py (path:/tmp/pip-RbrE4M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:52:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:52:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:52:23 INFO - Running setup.py (path:/tmp/pip-nZ783y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:52:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:52:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:52:23 INFO - Running setup.py (path:/tmp/pip-Qmj6zT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:52:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:52:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:52:23 INFO - Running setup.py (path:/tmp/pip-GuLYw0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:52:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:52:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:52:23 INFO - Running setup.py (path:/tmp/pip-bCYRjD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:52:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:52:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:52:23 INFO - Running setup.py (path:/tmp/pip-AO7ROg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:52:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:52:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:52:23 INFO - Running setup.py (path:/tmp/pip-pS3omT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:52:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:52:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:52:24 INFO - Running setup.py (path:/tmp/pip-ETCaNi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:52:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:52:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:52:24 INFO - Running setup.py (path:/tmp/pip-uqSZAV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:52:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:52:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:52:24 INFO - Running setup.py (path:/tmp/pip-dtxebx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:52:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:52:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:52:24 INFO - Running setup.py (path:/tmp/pip-n30q8y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:52:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:52:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:52:24 INFO - Running setup.py (path:/tmp/pip-ljEENS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:52:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:52:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:52:24 INFO - Running setup.py (path:/tmp/pip-GgMQLo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:52:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:52:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:52:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:52:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:52:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:52:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:52:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:52:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:52:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:52:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:26 INFO - Downloading blessings-1.6.tar.gz 03:52:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:52:26 INFO - Installing collected packages: blessings 03:52:26 INFO - Running setup.py install for blessings 03:52:26 INFO - Successfully installed blessings 03:52:26 INFO - Cleaning up... 03:52:26 INFO - Return code: 0 03:52:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:52:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:52:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:52:26 INFO - Reading from file tmpfile_stdout 03:52:26 INFO - Current package versions: 03:52:26 INFO - argparse == 1.2.1 03:52:26 INFO - blessings == 1.6 03:52:26 INFO - blobuploader == 1.2.4 03:52:26 INFO - docopt == 0.6.1 03:52:26 INFO - functools32 == 3.2.3-2 03:52:26 INFO - jsonschema == 2.5.1 03:52:26 INFO - manifestparser == 1.1 03:52:26 INFO - mozInstall == 1.12 03:52:26 INFO - mozcrash == 0.17 03:52:26 INFO - mozdebug == 0.1 03:52:26 INFO - mozdevice == 0.48 03:52:26 INFO - mozfile == 1.2 03:52:26 INFO - mozhttpd == 0.7 03:52:26 INFO - mozinfo == 0.9 03:52:26 INFO - mozleak == 0.1 03:52:26 INFO - mozlog == 3.3 03:52:26 INFO - moznetwork == 0.27 03:52:26 INFO - mozprocess == 0.23 03:52:26 INFO - mozprofile == 0.28 03:52:26 INFO - mozrunner == 6.12 03:52:26 INFO - mozscreenshot == 0.1 03:52:26 INFO - mozsystemmonitor == 0.3 03:52:26 INFO - moztest == 0.7 03:52:27 INFO - mozversion == 1.4 03:52:27 INFO - psutil == 3.1.1 03:52:27 INFO - requests == 1.2.3 03:52:27 INFO - wsgiref == 0.1.2 03:52:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:52:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:52:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:52:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x298a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aed8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bb9400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c48570>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c49470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c49900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1473849864.248523-1632268604', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:52:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:52:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:52:27 INFO - Using env: {'DISPLAY': ':0', 03:52:27 INFO - 'HOME': '/home/cltbld', 03:52:27 INFO - 'LANG': 'en_US.UTF-8', 03:52:27 INFO - 'LANGUAGE': 'en_US:en', 03:52:27 INFO - 'LOGNAME': 'cltbld', 03:52:27 INFO - 'MAIL': '/var/mail/cltbld', 03:52:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:27 INFO - 'MOZ_NO_REMOTE': '1', 03:52:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:27 INFO - 'NO_EM_RESTART': '1', 03:52:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:27 INFO - 'PWD': '/builds/slave/test', 03:52:27 INFO - 'SHELL': '/bin/bash', 03:52:27 INFO - 'SHLVL': '1', 03:52:27 INFO - 'TERM': 'linux', 03:52:27 INFO - 'TMOUT': '86400', 03:52:27 INFO - 'USER': 'cltbld', 03:52:27 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1473849864.248523-1632268604', 03:52:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:27 INFO - '_': '/tools/buildbot/bin/python'} 03:52:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:52:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:52:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:52:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:52:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:52:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:52:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:52:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:52:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:52:27 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:52:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:52:27 INFO - Cleaning up... 03:52:27 INFO - Return code: 0 03:52:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:52:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:52:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:52:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x298a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aed8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bb9400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c48570>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c49470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c49900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1473849864.248523-1632268604', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:52:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:52:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:52:27 INFO - Using env: {'DISPLAY': ':0', 03:52:27 INFO - 'HOME': '/home/cltbld', 03:52:27 INFO - 'LANG': 'en_US.UTF-8', 03:52:27 INFO - 'LANGUAGE': 'en_US:en', 03:52:27 INFO - 'LOGNAME': 'cltbld', 03:52:27 INFO - 'MAIL': '/var/mail/cltbld', 03:52:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:27 INFO - 'MOZ_NO_REMOTE': '1', 03:52:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:27 INFO - 'NO_EM_RESTART': '1', 03:52:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:27 INFO - 'PWD': '/builds/slave/test', 03:52:27 INFO - 'SHELL': '/bin/bash', 03:52:27 INFO - 'SHLVL': '1', 03:52:27 INFO - 'TERM': 'linux', 03:52:27 INFO - 'TMOUT': '86400', 03:52:27 INFO - 'USER': 'cltbld', 03:52:27 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1473849864.248523-1632268604', 03:52:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:27 INFO - '_': '/tools/buildbot/bin/python'} 03:52:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:27 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:52:27 INFO - Cleaning up... 03:52:27 INFO - Return code: 0 03:52:27 INFO - Running post-action listener: _resource_record_post_action 03:52:27 INFO - Running post-action listener: _start_resource_monitoring 03:52:27 INFO - Starting resource monitoring. 03:52:27 INFO - [mozharness: 2016-09-14 10:52:27.468766Z] Finished create-virtualenv step (success) 03:52:27 INFO - [mozharness: 2016-09-14 10:52:27.469241Z] Running install step. 03:52:27 INFO - Running pre-action listener: _resource_record_pre_action 03:52:27 INFO - Running main action method: install 03:52:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:52:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:52:27 INFO - Reading from file tmpfile_stdout 03:52:27 INFO - Detecting whether we're running mozinstall >=1.0... 03:52:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:52:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:52:27 INFO - Reading from file tmpfile_stdout 03:52:27 INFO - Output received: 03:52:27 INFO - Usage: mozinstall [options] installer 03:52:27 INFO - Options: 03:52:27 INFO - -h, --help show this help message and exit 03:52:27 INFO - -d DEST, --destination=DEST 03:52:27 INFO - Directory to install application into. [default: 03:52:27 INFO - "/builds/slave/test"] 03:52:27 INFO - --app=APP Application being installed. [default: firefox] 03:52:27 INFO - mkdir: /builds/slave/test/build/application 03:52:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:52:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:52:43 INFO - Reading from file tmpfile_stdout 03:52:43 INFO - Output received: 03:52:43 INFO - /builds/slave/test/build/application/firefox/firefox 03:52:43 INFO - Running post-action listener: _resource_record_post_action 03:52:43 INFO - [mozharness: 2016-09-14 10:52:43.827702Z] Finished install step (success) 03:52:43 INFO - [mozharness: 2016-09-14 10:52:43.828044Z] Running run-tests step. 03:52:43 INFO - Running pre-action listener: _resource_record_pre_action 03:52:43 INFO - Running main action method: run_tests 03:52:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:52:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:52:43 INFO - Python 2.7.3 03:52:43 INFO - Return code: 0 03:52:43 INFO - grabbing minidump binary from tooltool 03:52:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:52:43 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c48570>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c49470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c49900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:52:43 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:52:43 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:52:43 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 03:52:43 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:52:43 INFO - Return code: 0 03:52:43 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:52:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:52:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:52:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:52:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:52:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Rp6e7ySwSWqdPvDsHr_9Jg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 03:52:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Rp6e7ySwSWqdPvDsHr_9Jg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-024 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 03:52:43 INFO - Using env: {'DISPLAY': ':0', 03:52:43 INFO - 'HOME': '/home/cltbld', 03:52:43 INFO - 'LANG': 'en_US.UTF-8', 03:52:43 INFO - 'LANGUAGE': 'en_US:en', 03:52:43 INFO - 'LOGNAME': 'cltbld', 03:52:43 INFO - 'MAIL': '/var/mail/cltbld', 03:52:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:52:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:52:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:43 INFO - 'MOZ_NO_REMOTE': '1', 03:52:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:52:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:43 INFO - 'NO_EM_RESTART': '1', 03:52:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:43 INFO - 'PWD': '/builds/slave/test', 03:52:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:52:43 INFO - 'SHELL': '/bin/bash', 03:52:43 INFO - 'SHLVL': '1', 03:52:43 INFO - 'TERM': 'linux', 03:52:43 INFO - 'TMOUT': '86400', 03:52:43 INFO - 'USER': 'cltbld', 03:52:43 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1473849864.248523-1632268604', 03:52:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:43 INFO - '_': '/tools/buildbot/bin/python'} 03:52:43 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Rp6e7ySwSWqdPvDsHr_9Jg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 03:52:44 INFO - mozversion application_buildid: 20160914004005 03:52:44 INFO - mozversion application_changeset: 7852ac7e74faf5a637189437ce0a9a7f39e6292c 03:52:44 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:52:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:52:44 INFO - mozversion application_name: Firefox 03:52:44 INFO - mozversion application_remotingname: firefox-dev 03:52:44 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:52:44 INFO - mozversion application_vendor: Mozilla 03:52:44 INFO - mozversion application_version: 50.0a2 03:52:44 INFO - mozversion platform_buildid: 20160914004005 03:52:44 INFO - mozversion platform_changeset: 7852ac7e74faf5a637189437ce0a9a7f39e6292c 03:52:44 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:52:44 INFO - mozversion platform_version: 50.0a2 03:52:44 INFO - using testdate: 1473850364 03:52:44 INFO - actual date: 1473850364 03:52:44 INFO - starting webserver on 'localhost:42888' 03:52:44 INFO - SUITE-START | Running 2 tests 03:52:44 INFO - TEST-START | dromaeo_css 03:52:44 INFO - operating with platform_type : linux_ 03:52:44 INFO - Initialising browser for dromaeo_css test... 03:52:44 INFO - TEST-INFO | started process 21729 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLdACuI/profile http://localhost:42888/getInfo.html) 03:52:48 INFO - PROCESS | 21729 | __metrics Screen width/height:1600/1200 03:52:48 INFO - PROCESS | 21729 | colorDepth:24 03:52:48 INFO - PROCESS | 21729 | Browser inner width/height: 1024/697 03:52:48 INFO - PROCESS | 21729 | __metrics 03:52:49 ERROR - PROCESS | 21729 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 03:52:50 INFO - TEST-INFO | 21729: exit 0 03:52:50 INFO - Browser initialized. 03:52:50 INFO - Running cycle 1/1 for dromaeo_css test... 03:52:50 INFO - TEST-INFO | started process 21853 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLdACuI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:53:01 INFO - PROCESS | 21853 | RSS: Main: 152834048 03:53:01 INFO - PROCESS | 21853 | 03:53:51 INFO - PROCESS | 21853 | 1473850431502 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 03:56:00 INFO - PROCESS | 21853 | Cycle 1(1): loaded http://localhost:42888/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42888/tests/dromaeo/cssquery-ext.html) 03:56:01 INFO - PROCESS | 21853 | RSS: Main: 159309824 03:56:01 INFO - PROCESS | 21853 | 03:59:03 INFO - PROCESS | 21853 | Cycle 1(1): loaded http://localhost:42888/tests/dromaeo/cssquery-ext.html (next: http://localhost:42888/tests/dromaeo/cssquery-jquery.html) 03:59:04 INFO - PROCESS | 21853 | RSS: Main: 155230208 03:59:04 INFO - PROCESS | 21853 | 04:02:05 INFO - PROCESS | 21853 | Cycle 1(1): loaded http://localhost:42888/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42888/tests/dromaeo/cssquery-mootools.html) 04:02:06 INFO - PROCESS | 21853 | RSS: Main: 155869184 04:02:06 INFO - PROCESS | 21853 | 04:05:08 INFO - PROCESS | 21853 | Cycle 1(1): loaded http://localhost:42888/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42888/tests/dromaeo/cssquery-prototype.html) 04:05:08 INFO - PROCESS | 21853 | RSS: Main: 154914816 04:05:08 INFO - PROCESS | 21853 | 04:08:11 INFO - PROCESS | 21853 | Cycle 1(1): loaded http://localhost:42888/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42888/tests/dromaeo/cssquery-yui.html) 04:08:11 INFO - PROCESS | 21853 | RSS: Main: 157171712 04:08:11 INFO - PROCESS | 21853 | 04:11:14 INFO - PROCESS | 21853 | Cycle 1(1): loaded http://localhost:42888/tests/dromaeo/cssquery-yui.html (next: http://localhost:42888/tests/dromaeo/cssquery-dojo.html) 04:11:14 INFO - PROCESS | 21853 | RSS: Main: 157044736 04:11:14 INFO - PROCESS | 21853 | 04:11:14 INFO - PROCESS | 21853 | __start_tp_report 04:11:14 INFO - PROCESS | 21853 | _x_x_mozilla_page_load 04:11:14 INFO - PROCESS | 21853 | _x_x_mozilla_page_load_details 04:11:14 INFO - PROCESS | 21853 | |i|pagename|runs| 04:11:14 INFO - PROCESS | 21853 | |0;dojo.html;3278.5901762279714;3325.684060014301;3326.2682209913823;3327.8502467388967;3361.3277344531084;5721.542276617871;5752.53979681625;5776.855578610537;5798.3331916829575;5800.680962547069;5816.447437493442;5819.563532735051;5854.765809367631;5856.150858125569;5868.706564671771;5299.152135658305;5317;5317.282166907476;5369.892602147955;5392.4337944515655;5175.585953123741;5201.583873290147;5204.609654275925;5218.269442278084;5220.373555173365;5256.185291279858;5259.526642602165;5273.446288139748;5333.813316533922;5340.465953404668;5277.894442111136;5319.601029922752;5341.332333458317;5346.064438723208;5357.035733567956;5091.389033315989;5098.1842905135;5107.978404319114;5117.462666420047;5217.191335343028;5607.355154157283;5679.517241034517;5696.8006119785605;5698.202251684726;5730.169125476783;6099.57302988791;6110.358412366726;6134.447899689005;6138.47822935051;6166.845828854314;5924.940750592482;6064.302605200414;6076.665783381913;6131;6226.159468471789;5715.657060576337;5722.971385143048;5733.598648094677;5738.569607279429;5740.397258287861;6281.466075383552;6286.18279623646;6286.685665716695;6288.308286088527;6297.055441683784;5905.173275741399;5988.161657367972;6012.939870601325;6018.398160183947;6026.186464827192;6109.313572000199;6121.429499155747;6129.05316799051;6144.846378840475;6159.414855588801;6129.203203583595;6134.503712358416;6166;6171.444569988723;6176.197094377702;5881.882362352729;6065.029595264737;6107.786227482017;6142.57002009855;6162.969185154046;4706.905861882743;4708.788104535304;4712.434507859079;4729.69256998294;4750.691205071659;4204.07510347723;4215.683823713172;4216.7680777557525;4220.177065472203;4243.024104455931;5797.188393624896;5895.587308888336;5907.291125064934;5928.67392293428;5947.5539334550085;6246.562740608114;6286.52851036165;6292.4966002719675;6314.936850631435;6324.9051264231075;5948.7323070461935;5969.343372229051;5975.25309336333;5986.281646202484;6050.0017497112485;5221.55616772571;5266.683998960075;5299.046171689133;5300.04599172145;5375.16684913839;6390.8721825563225;6414.454771344394;6422.389872962061;6433.74265029403;6435.099086127946;6100.26796784371;6131.202943617302;6201.255849298113;6202.131701561695;6234.875302493834;6195.411435913581;6257.374262573706;6288.465480434214;6345.17512723343;6384.010478375859;6114.628125497783;6124.838682352551;6129.511613758974;6130.367562715148;6136.863136863137;6177.938220617736;6230.096635987847;6232.439080482778;6234.376562343729;6239.844003899939;5953.672548009901;6005.189299444519;6026.7287972040485;6077.270727512727;6087.299960504599;5998.4601385875485;6068.757249709962;6072.635641861502;6081.939180608138;6097.75608975636;5920.79277225295;5972.462478376967;5991.940080599138;6014.849628759316;6020.939790602038;5845.152452894392;5921.289445266596;5936.881262374642;5953.1070339449425;6066.969665151646;5838.737256823538;5852.795152169653;5853.94146058551;5868.119782032559;5876.735546900485 04:11:14 INFO - PROCESS | 21853 | |1;ext.html;585.2917969257198;638.2883085359823;658.2791842931988;662.3376623376623;709.6097146569385;42433.15133697328;47533.28700069502;47575.28637070442;47606.28590571135;47688;46301.53698463014;47151.292730608984;47374.526254737444;47449.28826067612;47598.76200619001;9087.4093183943;9231.723048308562;9272.07279272074;9279.675211367603;9279.814403711955;9155;9201.217896478774;9226.077392260753;9254.583543740548;9265.119813617695;9225.308101892351;9337.346385753;9354.532273386338;9355;9359.110884465965;9173.54132293386;9255.768605784875;9270.860937085949;9271.814563708756;9285.442873427548;9054.547272636342;9126.08739126082;9150.908490915139;9173.266138708887;9201;44720;45436.09127817425;45540.54459455396;45571.31643025357;45784.77107614474;3194.5847039884898;3692.46459263408;3706.9602925601016;3778.489903862971;3785.1861849702173;34290.82854585736;34444.48333275003;34530;34722.479162812575;34731;4499.730016199039;4519.638428925678;4547.173566879001;4551.067031258584;4585.862424127282;332672;332858.33570832235;333374;335628;335781;40270.59729402669;40346;40379.59620403758;40387;40395.79802100971;40428.1914361717;41060.79469602633;41110.38334424986;41213.793931030756;41317.58682413137;18573.34993275256;18650.626987460448;18677.626447470975;18679;18755.249790008518;14261.572152835432;14262;14440.927795361165;14456.638584035272;14505.927470362582;21117.577648446946;21551.353459396243;21633.134674613153;21675.45811354697;21722.456938576663;7310.561366318038;7450.552966822008;7545.962270188614;7709.884351734729;7861.921380786233;1000.7047920863363;1070.175964507325;1070.7117992440228;1085.7557049663762;1147.3345459633392;34928.12208003762;34996.125096872274;35369.46945795815;35670.82164589161;35795.284094318486;1172.9003034742143;1190.4940400329824;1222.1383924333325;1260.9558665446666;1289.7807372746656;17931.910340448216;18219.453416397264;18443.81556184448;18463.630727385647;18843.528911777314;604450;623340;623490;623630;628348;67451.66274168696;68299.65850170817;68584;68635;68697.65651171713;1402.1236727045596;1443.1557538839686;1449.173970836634;1467.530390275123;1469.5150600301874;35580.64419355773;36067.819660902576;36129.638703612625;36715.44926826153;37301.62698372982;58705.4129458717;59803;60119.39880601138;60215.698921505114;60363.698181508815;558544;560724;560832;561292;562242;31443.685563144074;31965.520517191795;32071.358572828878;32085.197870053435;32372.514412283363;54557.72721136369;54606;55217;55291;55813.162802557184;44051.33922991093;47066.529334707586;47656;48112.27831582459;48252.27621585609;47268.527314726416;47710;48121.75939120282;48212;48583;40020.79989600033;44171.11657766762;46188.07623847571;48872.51127488822;49087.509124909724;38891.833245002694;39900;40646.1870762589;41024;41630;30513.23716907095;30918.845405772827;30997.48642017253;31081.844590776902;31543 04:11:14 INFO - PROCESS | 21853 | |2;jquery.html;413.74968144272697;414.6040531292615;415.94800649918767;421.4626351401964;424.3210862619809;19447.541434392424;20109.698354524677;20995.685064724003;21087.472813179676;21206.787932120675;19626.313079042236;20085.59828803423;20145.59708805823;20685.172593096297;20847;6016.458518733313;6218.347073557256;6220.6267623942485;6224.408681175304;6247.250329960411;6029.879402411949;6062.545309101813;6064.120702498135;6097.237845269341;6140.447359737623;5896.941030589704;6054.394560543955;6056.303525094604;6056.454919057284;6073.331933487335;6000.36996115406;6006.429389208019;6049.969750151243;6068.575199735976;6070.089486577049;5315.096433606296;5463.071277882769;5463.426340234258;5470.124780035215;5480;24457.143999959917;24757;25138.12016579411;25236.87381563099;25859.0949316773;2490.66376039236;2520.710118336378;2553.0936517536193;2830.3490197254746;2913.6066631004755;15526.223688815515;15538.61153471161;16096.195190240442;16315.347386104542;16389.344426222935;2083.760367557735;2101.684747287904;2115.0910856938917;2182.748983866844;2215.2135991722866;62141.6892915537;78648.60675696585;83053.58473207656;91678.99999999933;92400;11083.944580277048;11190.888091119148;11539.134564907497;11602.825957610643;11642.301461912313;15812.288447019911;15816.920915395349;15881.28534215963;15903.840961590467;16000.119993400474;8600.13998600135;8701.086385929513;8808.823823523622;8818.29453643707;8980.506072166094;8604.139586041345;8633.870491942625;8690.304775617935;8834.734957951272;8875.778105547284;4707.693999890064;4766.308885211625;4817.470078291385;4838.153323168432;4940.530649588283;1992.5715971066;2039.7246371739923;2086.3428020173596;2092.299079808251;2166.393409845246;437.2763077107392;902.3052249767642;949.3259785552198;1042.671558459083;1055.2138656700806;11449.656510304705;12263.93868030654;12455.564055258023;12506.562270320495;12622.242665440102;469.71112765649565;472.3976929415023;475.6812935333335;476.0336516870758;483.60586122310207;6274.749010039547;6475.384838440435;6503.7073331700185;6512.185976752906;6536.934630653633;530512;533470;539288;571178;573551;92412.53793730988;93628.0637193633;100279.49860250652;105007;108956;1049.7375656085978;1074.4735079810837;1082.2045796339685;1095.4030053620795;1101.1686176936362;18194;18329.991850448354;18666.346677866208;18702.53243668865;18928.905355473686;47081;47305.29042064303;47633.285500716825;47726.284105739134;47810;59724.70137649284;60564.69717651384;60621.69689151526;62869.37130628635;70174;7950.3639708822;8110.878336824834;8196.262336389753;8250.339972802281;8290.709825156331;9498.715038548855;12112.515499380279;12136.939315303367;12138.875696752857;12430.627081187578;10964.342139471657;11306.152038596974;11341.886581134084;11373.14701397415;11442.199046066695;10777.46112694378;10924.50839712199;10988.956049175316;11096.778064438504;11279.210455268052;9886.752831179278;10472;10575.15398768112;10868.945655271673;11261;7990.640421181177;8048;8050.476719013245;8185.631646575799;8234.794130146554;7923.484973476706;9674.85487717699;10287.742806429898;10643.521041553304;10648.254622176373 04:11:14 INFO - PROCESS | 21853 | |3;mootools.html;1509.479229665765;1552.4411211963693;1720.7160818464954;1807.1957978699484;1855.396995976308;8293.58532073397;9102.590383432746;9308.162265396113;9766.121049105579;9804.117629413351;9326.114019168184;9780.266480013992;9782.706518804429;9792.902070979288;9809.460479673633;2497.051120574179;2533.050106210171;2533.809964252679;2534.1510593951048;2536.5941449368106;2349.4948586053997;2420.1650430601503;2427.635854621812;2429.9878500607474;2433.1605596069326;2510.2092840755104;2521.6595759572406;2521.684789401325;2527.3807917060344;2536.0236309020975;2338.251759436981;2356.175338631482;2371.9644205336936;2375.5248950209852;2376.4296568823356;2399.748026457214;2403.399150212447;2416.516696660675;2434.9756502434925;2477.6407420923865;9590.712278631652;9687.32188746788;9700.611975520971;9735.610575576968;9840.852387214198;5706.229658996065;5844.035734103868;5844.4739973402175;5856.267966504187;5857.76568937242;3631.110377957391;3729.869454569104;3771.453139294787;3818.274527839729;3853.0367408147963;1182.9053675705923;1211.3398197982121;1222.4987755020488;1225.3199474291764;1246.8940140088102;13632;13729.176249425067;13785.586432407044;13831.100978436369;13848.861511384857;5069.239614057847;5095.949040509548;5197.1164901966;5253.212018197224;5269.55208807248;10872.61945831892;10898.400587967579;10948.671539853816;10949.397783121845;10955.287906286067;5863.413658634187;5869.178315035899;5881.411858814085;5900.527957763368;5903.822885313448;4525.592696657317;5227.660202086852;5306.336707911511;5361.624686272002;5484.643498172606;3918.9804050979565;4070.75575465473;4083.8570650027104;4085.9182816343505;4170.998960249518;1163.8777928317575;1181.3974872814927;1182.1665725663386;1184.0350114656528;1194.4684615346262;937.2221056523069;940.4451373689556;1020.2246292817364;1088.548252475214;1091.6397588795678;6644.269130395653;6788.76239331621;6855.383015528626;6866.279040700654;7069.611171385521;1010.2978429991233;1075.876274228458;1113.8886111388958;1128.3793913347627;1138.174823253135;4436.711613745097;4470.575295346936;4595.724256544551;4622.491525932145;4713.434387873409;11634.185607007428;12043.87956120445;12176.634700958986;12201.084918631139;12226.20529665569;11969.88030119705;11980.101492388107;12047.277163370225;12097.032237420985;12131.150819442555;9126.81746365069;9214.124658157465;9231.584578693975;9238.399504032217;9256;6461.321561236191;6472.579282346633;6590.5716128451495;6650.800475985729;6669.1330127083165;11112.333260004425;11141.331520108819;11258.324500529994;11297.887021129683;11359.432028398713;10820.513076911715;11101.94449027782;11108.61119860801;11362.431878405881;11406.885931140583;8524.190201930807;8794.340424468062;8842.955785221033;8898;8911.019787823463;9450.243980481682;9515.429074255568;9585.616575337188;9617.615295388106;9632.614695412105;8241.752747417588;8263.917360826556;8341.749747507585;8401.663933442594;8422.284105851071;8202.876956845532;8237.50574965504;8321.12628174033;8430.241278284984;8556.443831150955;7902.367810575255;7928.801779955547;7956.681732730857;7972.840543188988;7992.680292788224;5679.74441150141;5697.943020569741;5793.044147715748;5808.883822323445;5830.82507524775;5424.1321388577635;5466.671999680032;5494.2582751328055;5569.777208911598;5613 04:11:14 INFO - PROCESS | 21853 | |4;prototype.html;324.34806039859876;333.5197315865155;336.88040745535335;343.30994700651684;344.3165316846059;5754.33825110112;5844.678542680151;5855.916655418745;5865;5866.472017518422;5740.110282906146;5752.137179423078;5784.710764461771;5799;5810.041343178371;4192.538820729717;4302.419173411597;4406.383106365095;4445;4450.755208463534;4423.159599676067;4429.247028005231;4437.1125774844995;4446.955530444703;4450.109978004412;4393.846215382462;4402.449693788277;4415.845445409412;4431.778411079449;4432.468103827529;4327.264365057932;4396;4418.889527761799;4439.445069366329;4440.911181776362;3832.6358995895343;3841.9231615367535;3844.038990252437;3847.633705271238;3847.7306588538813;5579.218909352694;5624.3250809902665;5630.296212973379;5637.830865074055;5655.179998900177;4858.805647774085;5053.393592768854;5089.618278629117;5128.820491282824;5134.845954621367;6052.485538729169;6064.757409703607;6113.908291375588;6116.776644671084;6119.785807496761;4231.788410579458;4242.787860606957;4264.9147017059795;4274.935875961863;4275.40144379787;6132.141500189977;6317;6320.367963203689;6342.270638876542;6355.809325720235;4335.501417336984;4340.634354276926;4341.3487976803735;4356.281213599784;4358.825646974085;4408;4419.469663640384;4420.955790442119;4425.782909699794;4432.3794668746405;4783.378160839138;5042.9747851261245;5100.642954993189;5101.923471147936;5126.461721519261;6130.620610362722;6139.754409823647;6142.662153581596;6166.969165154145;6167.444929956326;1463.8609332113433;1493;1508.2383396384755;1513.9243037848064;1519.574519134644;894.3784070071238;918.8621706744042;948.4735971535725;956.5791051937125;1045.8692663417073;5876.236089308362;5900.9999999999145;5921.792737254175;5938.930992421406;5943.138244954457;6170.192562384104;6178.227721534809;6208.410201030895;6223.906641400383;6231.470325022333;5678.801241956512;5936.287645482484;5957.404259574095;5991.430814072656;6010.398960103955;3351.312980838922;3354.765166438326;3363.9327213455595;3367.6463971282665;3379.341028499419;6321.810345689637;6418.935810641927;6473.190851143607;6489.643069631121;6548.1814773153355;6332.258628877095;6339.11252424661;6341;6361.791259660649;6421.454176395058;6377.585456945284;6398.208501619554;6520.347965203537;6529.608223506605;6538.934610653928;6294.181756371642;6323.557350985387;6344.555881088279;6351.68241587928;6359;6210.689465526615;6213.65824879636;6222.657753823402;6237.781677641261;6237.937620623736;6305.274893387319;6465.676716164267;6485.156929599122;6487.578307410004;6529.7061632227615;4395.933911061796;4418.668599854959;4419.381286619811;4424.75663838492;4436.3123715824095;6166.938330616636;6313.305536391085;6350.142730731477;6380.457661098859;6381.936180638134;6189.721462534107;6229.813105606839;6239.285910628891;6240.625562466266;6245.437910588069;6044.90932636002;6103.176071230505;6191.566590338633;6220.626762394271;6225.470834979077;5949.732262048132;6093.786717464867;6123.84690382744;6143.754249829957;6187;6181.412765787243;6219.160413344141;6226.221722284715;6229.657368844757;6281.937180628135;5880.558958078247;5997.790077347272;6053.909191362045;6055.182550355822;6084.630958034407 04:11:14 INFO - PROCESS | 21853 | |5;yui.html;735.8491509240606;789.0294937227214;832.2177153475733;832.7002279179494;941.4351389166499;16811.159442027896;17558.122093895287;18065;18086.186121624527;18130.818691813078;16166.75749863753;16299.185040747945;16375;16404.261808218627;16444.42444514442;868.8783570300163;874.7987962768551;883.1036497954581;890.6259371064136;890.7951171230588;871.2811930157613;873.1617647058799;874.7069731639876;876.7808047988003;878.8593824987971;917.9954100229489;921.7326975177191;922.524899676667;923.7782932096283;929.549168653206;919.0946917286467;919.595378033663;920.4937284493569;920.5949382271779;922.0088404964656;678.4233401608642;681.1995904811876;681.2744427185032;683.0164563029222;685;17128.057956812372;17131.314747410088;17154;17210.82789172105;17252.13739313029;14451.349689264009;14729.852701472955;14869.03351282174;15105.773413398698;15146.697066058618;14746.926265368604;14868.553943381716;15042.623934401618;15162;15456.381744730197;4661.254199328091;4679.74261415622;4776.188048031808;4792.353032340624;4827.831025914076;78498.6075069621;78526;86345.56827215887;89809.10190898138;92815.53592232063;12463.127581069419;12563.874361256454;12639.494420223273;12642.873571264354;12669.619911402673;22350.66474002891;22413.887930560242;22575.0969961203;22596.322110336718;22713.318600441682;9337.11297426757;9348.57931393089;9361.297902657328;9391.859122113174;9394.201492873046;5189.922151167735;5191.065608190486;5245.318108645928;5315.521603055744;5439.456054394608;3942.586028467027;4019.8593049243136;4027.476428064333;4052.412400202013;4060.6954478414236;689.5001124185026;696.7526528082458;699.9615021173885;702.0907924238124;713.5219403000002;616.0194973161308;693.1197379328225;719.4999475364676;719.6689522819457;720.2077714514097;10188.337758045704;10190.344358880744;10460.738481538023;10798.460076996118;11039.448027598588;680.3502654964497;701.6246308225075;741.3179874515458;749.4969570225779;758.6775620361325;5066.847994560169;5099.719515426687;5200.61789519552;5356.116240820299;5408.296921400193;78536.60731696419;109124.4543777276;116594;139148.3042584801;145804.27097864443;121747;122744;124954;127286;127343;76540.61729691428;88773;90668.54665726761;91576.54211728899;93910.53044734732;10486;10503.842442363219;10522.421266830397;10578.8413173804;10709.250352475252;55568;56709;56879.44042518014;57666.42333576611;58689.70655146697;75096;75767.62116189604;83948;86465.13534864571;87462.56268718616;13536.526221582197;13601;13755;13944.16335019902;14296.356663949939;15625.84374156244;15893.602659933595;15952.361905523649;16230;16507.58731031734;14659.267036648338;15021.549353518974;15035;15084.924575377492;15515.069095854285;14406.567802965928;15454.84545154579;15556.611084722972;15822.762658560361;15825.920870396036;14687.55937321882;14711.55865324042;14791.186484743443;14820.40718371253;15749;12180.75638487243;12216.26702397859;12574.559890403792;12735.108542401942;12855.935720321339;12437.440315186019;12481.56314528987;12611.93694031524;12822.807657885325;12881.291528965998 04:11:14 INFO - PROCESS | 21853 | __end_tp_report 04:11:14 INFO - PROCESS | 21853 | __start_cc_report 04:11:14 INFO - PROCESS | 21853 | _x_x_mozilla_cycle_collect,332 04:11:14 INFO - PROCESS | 21853 | __end_cc_report 04:11:14 INFO - PROCESS | 21853 | __startTimestamp1473851474465__endTimestamp 04:11:14 INFO - PROCESS | 21853 | 04:11:14 INFO - PROCESS | 21853 | ------- Summary: start ------- 04:11:14 INFO - PROCESS | 21853 | Number of tests: 6 04:11:14 INFO - PROCESS | 21853 | 04:11:14 INFO - PROCESS | 21853 | [#0] dojo.html Cycles:165 Average:5727.89 Median:5948.73 stddev:647.53 (10.9%) stddev-sans-first:620.35 04:11:14 INFO - PROCESS | 21853 | Values: 3278.6 3325.7 3326.3 3327.9 3361.3 5721.5 5752.5 5776.9 5798.3 5800.7 5816.4 5819.6 5854.8 5856.2 5868.7 5299.2 5317.0 5317.3 5369.9 5392.4 5175.6 5201.6 5204.6 5218.3 5220.4 5256.2 5259.5 5273.4 5333.8 5340.5 5277.9 5319.6 5341.3 5346.1 5357.0 5091.4 5098.2 5108.0 5117.5 5217.2 5607.4 5679.5 5696.8 5698.2 5730.2 6099.6 6110.4 6134.4 6138.5 6166.8 5924.9 6064.3 6076.7 6131.0 6226.2 5715.7 5723.0 5733.6 5738.6 5740.4 6281.5 6286.2 6286.7 6288.3 6297.1 5905.2 5988.2 6012.9 6018.4 6026.2 6109.3 6121.4 6129.1 6144.8 6159.4 6129.2 6134.5 6166.0 6171.4 6176.2 5881.9 6065.0 6107.8 6142.6 6163.0 4706.9 4708.8 4712.4 4729.7 4750.7 4204.1 4215.7 4216.8 4220.2 4243.0 5797.2 5895.6 5907.3 5928.7 5947.6 6246.6 6286.5 6292.5 6314.9 6324.9 5948.7 5969.3 5975.3 5986.3 6050.0 5221.6 5266.7 5299.0 5300.0 5375.2 6390.9 6414.5 6422.4 6433.7 6435.1 6100.3 6131.2 6201.3 6202.1 6234.9 6195.4 6257.4 6288.5 6345.2 6384.0 6114.6 6124.8 6129.5 6130.4 6136.9 6177.9 6230.1 6232.4 6234.4 6239.8 5953.7 6005.2 6026.7 6077.3 6087.3 5998.5 6068.8 6072.6 6081.9 6097.8 5920.8 5972.5 5991.9 6014.8 6020.9 5845.2 5921.3 5936.9 5953.1 6067.0 5838.7 5852.8 5853.9 5868.1 5876.7 04:11:14 INFO - PROCESS | 21853 | 04:11:14 INFO - PROCESS | 21853 | [#1] ext.html Cycles:180 Average:66913.45 Median:4509.68 stddev:138532.26 (3071.9%) stddev-sans-first:138831.36 04:11:14 INFO - PROCESS | 21853 | Values: 585.3 638.3 658.3 662.3 709.6 42433.2 47533.3 47575.3 47606.3 47688.0 46301.5 47151.3 47374.5 47449.3 47598.8 9087.4 9231.7 9272.1 9279.7 9279.8 9155.0 9201.2 9226.1 9254.6 9265.1 9225.3 9337.3 9354.5 9355.0 9359.1 9173.5 9255.8 9270.9 9271.8 9285.4 9054.5 9126.1 9150.9 9173.3 9201.0 44720.0 45436.1 45540.5 45571.3 45784.8 3194.6 3692.5 3707.0 3778.5 3785.2 34290.8 34444.5 34530.0 34722.5 34731.0 4499.7 4519.6 4547.2 4551.1 4585.9 332672.0 332858.3 333374.0 335628.0 335781.0 40270.6 40346.0 40379.6 40387.0 40395.8 40428.2 41060.8 41110.4 41213.8 41317.6 18573.3 18650.6 18677.6 18679.0 18755.2 14261.6 14262.0 14440.9 14456.6 14505.9 21117.6 21551.4 21633.1 21675.5 21722.5 7310.6 7450.6 7546.0 7709.9 7861.9 1000.7 1070.2 1070.7 1085.8 1147.3 34928.1 34996.1 35369.5 35670.8 35795.3 1172.9 1190.5 1222.1 1261.0 1289.8 17931.9 18219.5 18443.8 18463.6 18843.5 604450.0 623340.0 623490.0 623630.0 628348.0 67451.7 68299.7 68584.0 68635.0 68697.7 1402.1 1443.2 1449.2 1467.5 1469.5 35580.6 36067.8 36129.6 36715.4 37301.6 58705.4 59803.0 60119.4 60215.7 60363.7 558544.0 560724.0 560832.0 561292.0 562242.0 31443.7 31965.5 32071.4 32085.2 32372.5 54557.7 54606.0 55217.0 55291.0 55813.2 44051.3 47066.5 47656.0 48112.3 48252.3 47268.5 47710.0 48121.8 48212.0 48583.0 40020.8 44171.1 46188.1 48872.5 49087.5 38891.8 39900.0 40646.2 41024.0 41630.0 30513.2 30918.8 30997.5 31081.8 31543.0 04:11:14 INFO - PROCESS | 21853 | 04:11:14 INFO - PROCESS | 21853 | [#2] jquery.html Cycles:180 Average:31125.72 Median:430.80 stddev:90671.29 (21047.3%) stddev-sans-first:90896.32 04:11:14 INFO - PROCESS | 21853 | Values: 413.7 414.6 415.9 421.5 424.3 19447.5 20109.7 20995.7 21087.5 21206.8 19626.3 20085.6 20145.6 20685.2 20847.0 6016.5 6218.3 6220.6 6224.4 6247.3 6029.9 6062.5 6064.1 6097.2 6140.4 5896.9 6054.4 6056.3 6056.5 6073.3 6000.4 6006.4 6050.0 6068.6 6070.1 5315.1 5463.1 5463.4 5470.1 5480.0 24457.1 24757.0 25138.1 25236.9 25859.1 2490.7 2520.7 2553.1 2830.3 2913.6 15526.2 15538.6 16096.2 16315.3 16389.3 2083.8 2101.7 2115.1 2182.7 2215.2 62141.7 78648.6 83053.6 91679.0 92400.0 11083.9 11190.9 11539.1 11602.8 11642.3 15812.3 15816.9 15881.3 15903.8 16000.1 8600.1 8701.1 8808.8 8818.3 8980.5 8604.1 8633.9 8690.3 8834.7 8875.8 4707.7 4766.3 4817.5 4838.2 4940.5 1992.6 2039.7 2086.3 2092.3 2166.4 437.3 902.3 949.3 1042.7 1055.2 11449.7 12263.9 12455.6 12506.6 12622.2 469.7 472.4 475.7 476.0 483.6 6274.7 6475.4 6503.7 6512.2 6536.9 530512.0 533470.0 539288.0 571178.0 573551.0 92412.5 93628.1 100279.5 105007.0 108956.0 1049.7 1074.5 1082.2 1095.4 1101.2 18194.0 18330.0 18666.3 18702.5 18928.9 47081.0 47305.3 47633.3 47726.3 47810.0 59724.7 60564.7 60621.7 62869.4 70174.0 7950.4 8110.9 8196.3 8250.3 8290.7 9498.7 12112.5 12136.9 12138.9 12430.6 10964.3 11306.2 11341.9 11373.1 11442.2 10777.5 10924.5 10989.0 11096.8 11279.2 9886.8 10472.0 10575.2 10868.9 11261.0 7990.6 8048.0 8050.5 8185.6 8234.8 7923.5 9674.9 10287.7 10643.5 10648.3 04:11:14 INFO - PROCESS | 21853 | 04:11:14 INFO - PROCESS | 21853 | [#3] mootools.html Cycles:180 Average:6379.15 Median:4560.66 stddev:3665.88 (80.4%) stddev-sans-first:3657.90 04:11:14 INFO - PROCESS | 21853 | Values: 1509.5 1552.4 1720.7 1807.2 1855.4 8293.6 9102.6 9308.2 9766.1 9804.1 9326.1 9780.3 9782.7 9792.9 9809.5 2497.1 2533.1 2533.8 2534.2 2536.6 2349.5 2420.2 2427.6 2430.0 2433.2 2510.2 2521.7 2521.7 2527.4 2536.0 2338.3 2356.2 2372.0 2375.5 2376.4 2399.7 2403.4 2416.5 2435.0 2477.6 9590.7 9687.3 9700.6 9735.6 9840.9 5706.2 5844.0 5844.5 5856.3 5857.8 3631.1 3729.9 3771.5 3818.3 3853.0 1182.9 1211.3 1222.5 1225.3 1246.9 13632.0 13729.2 13785.6 13831.1 13848.9 5069.2 5095.9 5197.1 5253.2 5269.6 10872.6 10898.4 10948.7 10949.4 10955.3 5863.4 5869.2 5881.4 5900.5 5903.8 4525.6 5227.7 5306.3 5361.6 5484.6 3919.0 4070.8 4083.9 4085.9 4171.0 1163.9 1181.4 1182.2 1184.0 1194.5 937.2 940.4 1020.2 1088.5 1091.6 6644.3 6788.8 6855.4 6866.3 7069.6 1010.3 1075.9 1113.9 1128.4 1138.2 4436.7 4470.6 4595.7 4622.5 4713.4 11634.2 12043.9 12176.6 12201.1 12226.2 11969.9 11980.1 12047.3 12097.0 12131.2 9126.8 9214.1 9231.6 9238.4 9256.0 6461.3 6472.6 6590.6 6650.8 6669.1 11112.3 11141.3 11258.3 11297.9 11359.4 10820.5 11101.9 11108.6 11362.4 11406.9 8524.2 8794.3 8843.0 8898.0 8911.0 9450.2 9515.4 9585.6 9617.6 9632.6 8241.8 8263.9 8341.7 8401.7 8422.3 8202.9 8237.5 8321.1 8430.2 8556.4 7902.4 7928.8 7956.7 7972.8 7992.7 5679.7 5697.9 5793.0 5808.9 5830.8 5424.1 5466.7 5494.3 5569.8 5613.0 04:11:14 INFO - PROCESS | 21853 | 04:11:14 INFO - PROCESS | 21853 | [#4] prototype.html Cycles:180 Average:5119.26 Median:5929.04 stddev:1549.32 (26.1%) stddev-sans-first:1511.29 04:11:14 INFO - PROCESS | 21853 | Values: 324.3 333.5 336.9 343.3 344.3 5754.3 5844.7 5855.9 5865.0 5866.5 5740.1 5752.1 5784.7 5799.0 5810.0 4192.5 4302.4 4406.4 4445.0 4450.8 4423.2 4429.2 4437.1 4447.0 4450.1 4393.8 4402.4 4415.8 4431.8 4432.5 4327.3 4396.0 4418.9 4439.4 4440.9 3832.6 3841.9 3844.0 3847.6 3847.7 5579.2 5624.3 5630.3 5637.8 5655.2 4858.8 5053.4 5089.6 5128.8 5134.8 6052.5 6064.8 6113.9 6116.8 6119.8 4231.8 4242.8 4264.9 4274.9 4275.4 6132.1 6317.0 6320.4 6342.3 6355.8 4335.5 4340.6 4341.3 4356.3 4358.8 4408.0 4419.5 4421.0 4425.8 4432.4 4783.4 5043.0 5100.6 5101.9 5126.5 6130.6 6139.8 6142.7 6167.0 6167.4 1463.9 1493.0 1508.2 1513.9 1519.6 894.4 918.9 948.5 956.6 1045.9 5876.2 5901.0 5921.8 5938.9 5943.1 6170.2 6178.2 6208.4 6223.9 6231.5 5678.8 5936.3 5957.4 5991.4 6010.4 3351.3 3354.8 3363.9 3367.6 3379.3 6321.8 6418.9 6473.2 6489.6 6548.2 6332.3 6339.1 6341.0 6361.8 6421.5 6377.6 6398.2 6520.3 6529.6 6538.9 6294.2 6323.6 6344.6 6351.7 6359.0 6210.7 6213.7 6222.7 6237.8 6237.9 6305.3 6465.7 6485.2 6487.6 6529.7 4395.9 4418.7 4419.4 4424.8 4436.3 6166.9 6313.3 6350.1 6380.5 6381.9 6189.7 6229.8 6239.3 6240.6 6245.4 6044.9 6103.2 6191.6 6220.6 6225.5 5949.7 6093.8 6123.8 6143.8 6187.0 6181.4 6219.2 6226.2 6229.7 6281.9 5880.6 5997.8 6053.9 6055.2 6084.6 04:11:14 INFO - PROCESS | 21853 | 04:11:14 INFO - PROCESS | 21853 | [#5] yui.html Cycles:180 Average:23019.51 Median:4023.67 stddev:33392.35 (829.9%) stddev-sans-first:33444.11 04:11:14 INFO - PROCESS | 21853 | Values: 735.8 789.0 832.2 832.7 941.4 16811.2 17558.1 18065.0 18086.2 18130.8 16166.8 16299.2 16375.0 16404.3 16444.4 868.9 874.8 883.1 890.6 890.8 871.3 873.2 874.7 876.8 878.9 918.0 921.7 922.5 923.8 929.5 919.1 919.6 920.5 920.6 922.0 678.4 681.2 681.3 683.0 685.0 17128.1 17131.3 17154.0 17210.8 17252.1 14451.3 14729.9 14869.0 15105.8 15146.7 14746.9 14868.6 15042.6 15162.0 15456.4 4661.3 4679.7 4776.2 4792.4 4827.8 78498.6 78526.0 86345.6 89809.1 92815.5 12463.1 12563.9 12639.5 12642.9 12669.6 22350.7 22413.9 22575.1 22596.3 22713.3 9337.1 9348.6 9361.3 9391.9 9394.2 5189.9 5191.1 5245.3 5315.5 5439.5 3942.6 4019.9 4027.5 4052.4 4060.7 689.5 696.8 700.0 702.1 713.5 616.0 693.1 719.5 719.7 720.2 10188.3 10190.3 10460.7 10798.5 11039.4 680.4 701.6 741.3 749.5 758.7 5066.8 5099.7 5200.6 5356.1 5408.3 78536.6 109124.5 116594.0 139148.3 145804.3 121747.0 122744.0 124954.0 127286.0 127343.0 76540.6 88773.0 90668.5 91576.5 93910.5 10486.0 10503.8 10522.4 10578.8 10709.3 55568.0 56709.0 56879.4 57666.4 58689.7 75096.0 75767.6 83948.0 86465.1 87462.6 13536.5 13601.0 13755.0 13944.2 14296.4 15625.8 15893.6 15952.4 16230.0 16507.6 14659.3 15021.5 15035.0 15084.9 15515.1 14406.6 15454.8 15556.6 15822.8 15825.9 14687.6 14711.6 14791.2 14820.4 15749.0 12180.8 12216.3 12574.6 12735.1 12855.9 12437.4 12481.6 12611.9 12822.8 12881.3 04:11:14 INFO - PROCESS | 21853 | -------- Summary: end -------- 04:11:14 INFO - PROCESS | 21853 | 04:11:15 INFO - TEST-INFO | 21853: exit 0 04:11:15 INFO - TEST-OK | dromaeo_css | took 1111107ms 04:11:15 INFO - TEST-START | kraken 04:11:15 INFO - operating with platform_type : linux_ 04:11:15 INFO - Initialising browser for kraken test... 04:11:15 INFO - TEST-INFO | started process 22112 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAgboMD/profile http://localhost:42888/getInfo.html) 04:11:19 INFO - PROCESS | 22112 | __metrics Screen width/height:1600/1200 04:11:19 INFO - PROCESS | 22112 | colorDepth:24 04:11:19 INFO - PROCESS | 22112 | Browser inner width/height: 1024/697 04:11:19 INFO - PROCESS | 22112 | __metrics 04:11:20 ERROR - PROCESS | 22112 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 04:11:21 INFO - TEST-INFO | 22112: exit 0 04:11:21 INFO - Browser initialized. 04:11:21 INFO - Running cycle 1/1 for kraken test... 04:11:21 INFO - TEST-INFO | started process 22242 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAgboMD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:11:32 INFO - PROCESS | 22242 | RSS: Main: 153169920 04:11:32 INFO - PROCESS | 22242 | 04:11:35 INFO - PROCESS | 22242 | Cycle 1(1): loaded http://localhost:42888/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42888/tests/kraken/driver.html?testName=audio-beat-detection) 04:11:36 INFO - PROCESS | 22242 | RSS: Main: 158797824 04:11:36 INFO - PROCESS | 22242 | 04:11:38 INFO - PROCESS | 22242 | Cycle 1(1): loaded http://localhost:42888/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42888/tests/kraken/driver.html?testName=audio-dft) 04:11:39 INFO - PROCESS | 22242 | RSS: Main: 157560832 04:11:39 INFO - PROCESS | 22242 | 04:11:42 INFO - PROCESS | 22242 | Cycle 1(1): loaded http://localhost:42888/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42888/tests/kraken/driver.html?testName=audio-fft) 04:11:43 INFO - PROCESS | 22242 | RSS: Main: 157958144 04:11:43 INFO - PROCESS | 22242 | 04:11:45 INFO - PROCESS | 22242 | Cycle 1(1): loaded http://localhost:42888/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42888/tests/kraken/driver.html?testName=audio-oscillator) 04:11:45 INFO - PROCESS | 22242 | RSS: Main: 157790208 04:11:45 INFO - PROCESS | 22242 | 04:11:47 INFO - PROCESS | 22242 | Cycle 1(1): loaded http://localhost:42888/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42888/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:11:48 INFO - PROCESS | 22242 | RSS: Main: 158003200 04:11:48 INFO - PROCESS | 22242 | 04:11:51 INFO - PROCESS | 22242 | Cycle 1(1): loaded http://localhost:42888/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42888/tests/kraken/driver.html?testName=imaging-darkroom) 04:11:52 INFO - PROCESS | 22242 | RSS: Main: 157761536 04:11:52 INFO - PROCESS | 22242 | 04:11:55 INFO - PROCESS | 22242 | Cycle 1(1): loaded http://localhost:42888/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42888/tests/kraken/driver.html?testName=imaging-desaturate) 04:11:56 INFO - PROCESS | 22242 | RSS: Main: 155516928 04:11:56 INFO - PROCESS | 22242 | 04:11:59 INFO - PROCESS | 22242 | Cycle 1(1): loaded http://localhost:42888/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42888/tests/kraken/driver.html?testName=json-parse-financial) 04:11:59 INFO - PROCESS | 22242 | RSS: Main: 157335552 04:11:59 INFO - PROCESS | 22242 | 04:12:01 INFO - PROCESS | 22242 | Cycle 1(1): loaded http://localhost:42888/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42888/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:12:01 INFO - PROCESS | 22242 | RSS: Main: 156942336 04:12:01 INFO - PROCESS | 22242 | 04:12:03 INFO - PROCESS | 22242 | Cycle 1(1): loaded http://localhost:42888/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42888/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:12:04 INFO - PROCESS | 22242 | RSS: Main: 157351936 04:12:04 INFO - PROCESS | 22242 | 04:12:06 INFO - PROCESS | 22242 | Cycle 1(1): loaded http://localhost:42888/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42888/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:12:07 INFO - PROCESS | 22242 | RSS: Main: 157925376 04:12:07 INFO - PROCESS | 22242 | 04:12:09 INFO - PROCESS | 22242 | Cycle 1(1): loaded http://localhost:42888/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42888/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:12:10 INFO - PROCESS | 22242 | RSS: Main: 157212672 04:12:10 INFO - PROCESS | 22242 | 04:12:12 INFO - PROCESS | 22242 | Cycle 1(1): loaded http://localhost:42888/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42888/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:12:13 INFO - PROCESS | 22242 | RSS: Main: 158707712 04:12:13 INFO - PROCESS | 22242 | 04:12:15 INFO - PROCESS | 22242 | Cycle 1(1): loaded http://localhost:42888/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42888/tests/kraken/driver.html?testName=ai-astar) 04:12:15 INFO - PROCESS | 22242 | RSS: Main: 159870976 04:12:15 INFO - PROCESS | 22242 | 04:12:15 INFO - PROCESS | 22242 | __start_tp_report 04:12:15 INFO - PROCESS | 22242 | _x_x_mozilla_page_load 04:12:15 INFO - PROCESS | 22242 | _x_x_mozilla_page_load_details 04:12:15 INFO - PROCESS | 22242 | |i|pagename|runs| 04:12:15 INFO - PROCESS | 22242 | |0;ai-astar;107;109;103;111;109;111;97;113;109;109 04:12:15 INFO - PROCESS | 22242 | |1;audio-beat-detection;149;116;146;171;119;147;142;122;180;116 04:12:15 INFO - PROCESS | 22242 | |2;audio-dft;161;165;162;164;163;163;162;162;161;162 04:12:15 INFO - PROCESS | 22242 | |3;audio-fft;75;76;76;186;76;76;76;76;164;77 04:12:15 INFO - PROCESS | 22242 | |4;audio-oscillator;84;86;148;85;84;85;131;86;84;138 04:12:15 INFO - PROCESS | 22242 | |5;imaging-gaussian-blur;118;118;117;118;117;117;118;118;118;118 04:12:15 INFO - PROCESS | 22242 | |6;imaging-darkroom;147;147;147;146;147;146;146;146;147;146 04:12:15 INFO - PROCESS | 22242 | |7;imaging-desaturate;95;95;98;95;96;95;94;96;96;95 04:12:15 INFO - PROCESS | 22242 | |8;json-parse-financial;59;52;52;53;54;54;53;52;52;53 04:12:15 INFO - PROCESS | 22242 | |9;json-stringify-tinderbox;58;58;58;58;62;58;59;59;60;59 04:12:15 INFO - PROCESS | 22242 | |10;stanford-crypto-aes;74;81;74;72;73;73;74;72;72;73 04:12:15 INFO - PROCESS | 22242 | |11;stanford-crypto-ccm;119;119;120;130;132;126;117;116;156;116 04:12:15 INFO - PROCESS | 22242 | |12;stanford-crypto-pbkdf2;153;152;158;154;154;158;153;153;156;152 04:12:15 INFO - PROCESS | 22242 | |13;stanford-crypto-sha256-iterative;64;63;63;64;61;62;62;62;62;64 04:12:15 INFO - PROCESS | 22242 | __end_tp_report 04:12:15 INFO - PROCESS | 22242 | __start_cc_report 04:12:15 INFO - PROCESS | 22242 | _x_x_mozilla_cycle_collect,899 04:12:15 INFO - PROCESS | 22242 | __end_cc_report 04:12:15 INFO - PROCESS | 22242 | __startTimestamp1473851535403__endTimestamp 04:12:15 INFO - PROCESS | 22242 | 04:12:15 INFO - PROCESS | 22242 | ------- Summary: start ------- 04:12:15 INFO - PROCESS | 22242 | Number of tests: 14 04:12:15 INFO - PROCESS | 22242 | 04:12:15 INFO - PROCESS | 22242 | [#0] ai-astar Cycles:10 Average:107.80 Median:110.00 stddev:4.64 (4.2%) stddev-sans-first:4.91 04:12:15 INFO - PROCESS | 22242 | Values: 107.0 109.0 103.0 111.0 109.0 111.0 97.0 113.0 109.0 109.0 04:12:15 INFO - PROCESS | 22242 | 04:12:15 INFO - PROCESS | 22242 | [#1] audio-beat-detection Cycles:10 Average:140.80 Median:146.50 stddev:22.71 (15.5%) stddev-sans-first:23.89 04:12:15 INFO - PROCESS | 22242 | Values: 149.0 116.0 146.0 171.0 119.0 147.0 142.0 122.0 180.0 116.0 04:12:15 INFO - PROCESS | 22242 | 04:12:15 INFO - PROCESS | 22242 | [#2] audio-dft Cycles:10 Average:162.50 Median:162.50 stddev:1.27 (0.8%) stddev-sans-first:1.22 04:12:15 INFO - PROCESS | 22242 | Values: 161.0 165.0 162.0 164.0 163.0 163.0 162.0 162.0 161.0 162.0 04:12:15 INFO - PROCESS | 22242 | 04:12:15 INFO - PROCESS | 22242 | [#3] audio-fft Cycles:10 Average:95.80 Median:76.00 stddev:42.07 (55.3%) stddev-sans-first:43.94 04:12:15 INFO - PROCESS | 22242 | Values: 75.0 76.0 76.0 186.0 76.0 76.0 76.0 76.0 164.0 77.0 04:12:15 INFO - PROCESS | 22242 | 04:12:15 INFO - PROCESS | 22242 | [#4] audio-oscillator Cycles:10 Average:101.10 Median:84.50 stddev:26.47 (31.3%) stddev-sans-first:27.35 04:12:15 INFO - PROCESS | 22242 | Values: 84.0 86.0 148.0 85.0 84.0 85.0 131.0 86.0 84.0 138.0 04:12:15 INFO - PROCESS | 22242 | 04:12:15 INFO - PROCESS | 22242 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 04:12:15 INFO - PROCESS | 22242 | Values: 118.0 118.0 117.0 118.0 117.0 117.0 118.0 118.0 118.0 118.0 04:12:15 INFO - PROCESS | 22242 | 04:12:15 INFO - PROCESS | 22242 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 04:12:15 INFO - PROCESS | 22242 | Values: 147.0 147.0 147.0 146.0 147.0 146.0 146.0 146.0 147.0 146.0 04:12:15 INFO - PROCESS | 22242 | 04:12:15 INFO - PROCESS | 22242 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:95.50 stddev:1.08 (1.1%) stddev-sans-first:1.13 04:12:15 INFO - PROCESS | 22242 | Values: 95.0 95.0 98.0 95.0 96.0 95.0 94.0 96.0 96.0 95.0 04:12:15 INFO - PROCESS | 22242 | 04:12:15 INFO - PROCESS | 22242 | [#8] json-parse-financial Cycles:10 Average:53.40 Median:53.00 stddev:2.12 (4.0%) stddev-sans-first:0.83 04:12:15 INFO - PROCESS | 22242 | Values: 59.0 52.0 52.0 53.0 54.0 54.0 53.0 52.0 52.0 53.0 04:12:15 INFO - PROCESS | 22242 | 04:12:15 INFO - PROCESS | 22242 | [#9] json-stringify-tinderbox Cycles:10 Average:58.90 Median:59.00 stddev:1.29 (2.2%) stddev-sans-first:1.32 04:12:15 INFO - PROCESS | 22242 | Values: 58.0 58.0 58.0 58.0 62.0 58.0 59.0 59.0 60.0 59.0 04:12:15 INFO - PROCESS | 22242 | 04:12:15 INFO - PROCESS | 22242 | [#10] stanford-crypto-aes Cycles:10 Average:73.80 Median:73.50 stddev:2.66 (3.6%) stddev-sans-first:2.82 04:12:15 INFO - PROCESS | 22242 | Values: 74.0 81.0 74.0 72.0 73.0 73.0 74.0 72.0 72.0 73.0 04:12:15 INFO - PROCESS | 22242 | 04:12:15 INFO - PROCESS | 22242 | [#11] stanford-crypto-ccm Cycles:10 Average:125.10 Median:123.00 stddev:12.29 (10.0%) stddev-sans-first:12.83 04:12:15 INFO - PROCESS | 22242 | Values: 119.0 119.0 120.0 130.0 132.0 126.0 117.0 116.0 156.0 116.0 04:12:15 INFO - PROCESS | 22242 | 04:12:15 INFO - PROCESS | 22242 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.30 Median:154.00 stddev:2.26 (1.5%) stddev-sans-first:2.35 04:12:15 INFO - PROCESS | 22242 | Values: 153.0 152.0 158.0 154.0 154.0 158.0 153.0 153.0 156.0 152.0 04:12:15 INFO - PROCESS | 22242 | 04:12:15 INFO - PROCESS | 22242 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.70 Median:63.00 stddev:1.06 (1.7%) stddev-sans-first:1.01 04:12:15 INFO - PROCESS | 22242 | Values: 64.0 63.0 63.0 64.0 61.0 62.0 62.0 62.0 62.0 64.0 04:12:15 INFO - PROCESS | 22242 | -------- Summary: end -------- 04:12:15 INFO - PROCESS | 22242 | 04:12:16 INFO - TEST-INFO | 22242: exit 0 04:12:16 INFO - TEST-OK | kraken | took 61160ms 04:12:16 INFO - SUITE-END | took 1172s 04:12:16 INFO - Completed test suite (00:19:32) 04:12:16 INFO - javascript benchmark 04:12:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7749.218861622667, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3278.5901762279714, 3325.684060014301, 3326.2682209913823, 3327.8502467388967, 3361.3277344531084, 5721.542276617871, 5752.53979681625, 5776.855578610537, 5798.3331916829575, 5800.680962547069, 5816.447437493442, 5819.563532735051, 5854.765809367631, 5856.150858125569, 5868.706564671771, 5299.152135658305, 5317.0, 5317.282166907476, 5369.892602147955, 5392.4337944515655, 5175.585953123741, 5201.583873290147, 5204.609654275925, 5218.269442278084, 5220.373555173365, 5256.185291279858, 5259.526642602165, 5273.446288139748, 5333.813316533922, 5340.465953404668, 5277.894442111136, 5319.601029922752, 5341.332333458317, 5346.064438723208, 5357.035733567956, 5091.389033315989, 5098.1842905135, 5107.978404319114, 5117.462666420047, 5217.191335343028, 5607.355154157283, 5679.517241034517, 5696.8006119785605, 5698.202251684726, 5730.169125476783, 6099.57302988791, 6110.358412366726, 6134.447899689005, 6138.47822935051, 6166.845828854314, 5924.940750592482, 6064.302605200414, 6076.665783381913, 6131.0, 6226.159468471789, 5715.657060576337, 5722.971385143048, 5733.598648094677, 5738.569607279429, 5740.397258287861, 6281.466075383552, 6286.18279623646, 6286.685665716695, 6288.308286088527, 6297.055441683784, 5905.173275741399, 5988.161657367972, 6012.939870601325, 6018.398160183947, 6026.186464827192, 6109.313572000199, 6121.429499155747, 6129.05316799051, 6144.846378840475, 6159.414855588801, 6129.203203583595, 6134.503712358416, 6166.0, 6171.444569988723, 6176.197094377702, 5881.882362352729, 6065.029595264737, 6107.786227482017, 6142.57002009855, 6162.969185154046, 4706.905861882743, 4708.788104535304, 4712.434507859079, 4729.69256998294, 4750.691205071659, 4204.07510347723, 4215.683823713172, 4216.7680777557525, 4220.177065472203, 4243.024104455931, 5797.188393624896, 5895.587308888336, 5907.291125064934, 5928.67392293428, 5947.5539334550085, 6246.562740608114, 6286.52851036165, 6292.4966002719675, 6314.936850631435, 6324.9051264231075, 5948.7323070461935, 5969.343372229051, 5975.25309336333, 5986.281646202484, 6050.0017497112485, 5221.55616772571, 5266.683998960075, 5299.046171689133, 5300.04599172145, 5375.16684913839, 6390.8721825563225, 6414.454771344394, 6422.389872962061, 6433.74265029403, 6435.099086127946, 6100.26796784371, 6131.202943617302, 6201.255849298113, 6202.131701561695, 6234.875302493834, 6195.411435913581, 6257.374262573706, 6288.465480434214, 6345.17512723343, 6384.010478375859, 6114.628125497783, 6124.838682352551, 6129.511613758974, 6130.367562715148, 6136.863136863137, 6177.938220617736, 6230.096635987847, 6232.439080482778, 6234.376562343729, 6239.844003899939, 5953.672548009901, 6005.189299444519, 6026.7287972040485, 6077.270727512727, 6087.299960504599, 5998.4601385875485, 6068.757249709962, 6072.635641861502, 6081.939180608138, 6097.75608975636, 5920.79277225295, 5972.462478376967, 5991.940080599138, 6014.849628759316, 6020.939790602038, 5845.152452894392, 5921.289445266596, 5936.881262374642, 5953.1070339449425, 6066.969665151646, 5838.737256823538, 5852.795152169653, 5853.94146058551, 5868.119782032559, 5876.735546900485], "value": 5684.0738195125705, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [585.2917969257198, 638.2883085359823, 658.2791842931988, 662.3376623376623, 709.6097146569385, 42433.15133697328, 47533.28700069502, 47575.28637070442, 47606.28590571135, 47688.0, 46301.53698463014, 47151.292730608984, 47374.526254737444, 47449.28826067612, 47598.76200619001, 9087.4093183943, 9231.723048308562, 9272.07279272074, 9279.675211367603, 9279.814403711955, 9155.0, 9201.217896478774, 9226.077392260753, 9254.583543740548, 9265.119813617695, 9225.308101892351, 9337.346385753, 9354.532273386338, 9355.0, 9359.110884465965, 9173.54132293386, 9255.768605784875, 9270.860937085949, 9271.814563708756, 9285.442873427548, 9054.547272636342, 9126.08739126082, 9150.908490915139, 9173.266138708887, 9201.0, 44720.0, 45436.09127817425, 45540.54459455396, 45571.31643025357, 45784.77107614474, 3194.5847039884898, 3692.46459263408, 3706.9602925601016, 3778.489903862971, 3785.1861849702173, 34290.82854585736, 34444.48333275003, 34530.0, 34722.479162812575, 34731.0, 4499.730016199039, 4519.638428925678, 4547.173566879001, 4551.067031258584, 4585.862424127282, 332672.0, 332858.33570832235, 333374.0, 335628.0, 335781.0, 40270.59729402669, 40346.0, 40379.59620403758, 40387.0, 40395.79802100971, 40428.1914361717, 41060.79469602633, 41110.38334424986, 41213.793931030756, 41317.58682413137, 18573.34993275256, 18650.626987460448, 18677.626447470975, 18679.0, 18755.249790008518, 14261.572152835432, 14262.0, 14440.927795361165, 14456.638584035272, 14505.927470362582, 21117.577648446946, 21551.353459396243, 21633.134674613153, 21675.45811354697, 21722.456938576663, 7310.561366318038, 7450.552966822008, 7545.962270188614, 7709.884351734729, 7861.921380786233, 1000.7047920863363, 1070.175964507325, 1070.7117992440228, 1085.7557049663762, 1147.3345459633392, 34928.12208003762, 34996.125096872274, 35369.46945795815, 35670.82164589161, 35795.284094318486, 1172.9003034742143, 1190.4940400329824, 1222.1383924333325, 1260.9558665446666, 1289.7807372746656, 17931.910340448216, 18219.453416397264, 18443.81556184448, 18463.630727385647, 18843.528911777314, 604450.0, 623340.0, 623490.0, 623630.0, 628348.0, 67451.66274168696, 68299.65850170817, 68584.0, 68635.0, 68697.65651171713, 1402.1236727045596, 1443.1557538839686, 1449.173970836634, 1467.530390275123, 1469.5150600301874, 35580.64419355773, 36067.819660902576, 36129.638703612625, 36715.44926826153, 37301.62698372982, 58705.4129458717, 59803.0, 60119.39880601138, 60215.698921505114, 60363.698181508815, 558544.0, 560724.0, 560832.0, 561292.0, 562242.0, 31443.685563144074, 31965.520517191795, 32071.358572828878, 32085.197870053435, 32372.514412283363, 54557.72721136369, 54606.0, 55217.0, 55291.0, 55813.162802557184, 44051.33922991093, 47066.529334707586, 47656.0, 48112.27831582459, 48252.27621585609, 47268.527314726416, 47710.0, 48121.75939120282, 48212.0, 48583.0, 40020.79989600033, 44171.11657766762, 46188.07623847571, 48872.51127488822, 49087.509124909724, 38891.833245002694, 39900.0, 40646.1870762589, 41024.0, 41630.0, 30513.23716907095, 30918.845405772827, 30997.48642017253, 31081.844590776902, 31543.0], "value": 21469.366828647722, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [413.74968144272697, 414.6040531292615, 415.94800649918767, 421.4626351401964, 424.3210862619809, 19447.541434392424, 20109.698354524677, 20995.685064724003, 21087.472813179676, 21206.787932120675, 19626.313079042236, 20085.59828803423, 20145.59708805823, 20685.172593096297, 20847.0, 6016.458518733313, 6218.347073557256, 6220.6267623942485, 6224.408681175304, 6247.250329960411, 6029.879402411949, 6062.545309101813, 6064.120702498135, 6097.237845269341, 6140.447359737623, 5896.941030589704, 6054.394560543955, 6056.303525094604, 6056.454919057284, 6073.331933487335, 6000.36996115406, 6006.429389208019, 6049.969750151243, 6068.575199735976, 6070.089486577049, 5315.096433606296, 5463.071277882769, 5463.426340234258, 5470.124780035215, 5480.0, 24457.143999959917, 24757.0, 25138.12016579411, 25236.87381563099, 25859.0949316773, 2490.66376039236, 2520.710118336378, 2553.0936517536193, 2830.3490197254746, 2913.6066631004755, 15526.223688815515, 15538.61153471161, 16096.195190240442, 16315.347386104542, 16389.344426222935, 2083.760367557735, 2101.684747287904, 2115.0910856938917, 2182.748983866844, 2215.2135991722866, 62141.6892915537, 78648.60675696585, 83053.58473207656, 91678.99999999933, 92400.0, 11083.944580277048, 11190.888091119148, 11539.134564907497, 11602.825957610643, 11642.301461912313, 15812.288447019911, 15816.920915395349, 15881.28534215963, 15903.840961590467, 16000.119993400474, 8600.13998600135, 8701.086385929513, 8808.823823523622, 8818.29453643707, 8980.506072166094, 8604.139586041345, 8633.870491942625, 8690.304775617935, 8834.734957951272, 8875.778105547284, 4707.693999890064, 4766.308885211625, 4817.470078291385, 4838.153323168432, 4940.530649588283, 1992.5715971066, 2039.7246371739923, 2086.3428020173596, 2092.299079808251, 2166.393409845246, 437.2763077107392, 902.3052249767642, 949.3259785552198, 1042.671558459083, 1055.2138656700806, 11449.656510304705, 12263.93868030654, 12455.564055258023, 12506.562270320495, 12622.242665440102, 469.71112765649565, 472.3976929415023, 475.6812935333335, 476.0336516870758, 483.60586122310207, 6274.749010039547, 6475.384838440435, 6503.7073331700185, 6512.185976752906, 6536.934630653633, 530512.0, 533470.0, 539288.0, 571178.0, 573551.0, 92412.53793730988, 93628.0637193633, 100279.49860250652, 105007.0, 108956.0, 1049.7375656085978, 1074.4735079810837, 1082.2045796339685, 1095.4030053620795, 1101.1686176936362, 18194.0, 18329.991850448354, 18666.346677866208, 18702.53243668865, 18928.905355473686, 47081.0, 47305.29042064303, 47633.285500716825, 47726.284105739134, 47810.0, 59724.70137649284, 60564.69717651384, 60621.69689151526, 62869.37130628635, 70174.0, 7950.3639708822, 8110.878336824834, 8196.262336389753, 8250.339972802281, 8290.709825156331, 9498.715038548855, 12112.515499380279, 12136.939315303367, 12138.875696752857, 12430.627081187578, 10964.342139471657, 11306.152038596974, 11341.886581134084, 11373.14701397415, 11442.199046066695, 10777.46112694378, 10924.50839712199, 10988.956049175316, 11096.778064438504, 11279.210455268052, 9886.752831179278, 10472.0, 10575.15398768112, 10868.945655271673, 11261.0, 7990.640421181177, 8048.0, 8050.476719013245, 8185.631646575799, 8234.794130146554, 7923.484973476706, 9674.85487717699, 10287.742806429898, 10643.521041553304, 10648.254622176373], "value": 9123.044122069377, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1509.479229665765, 1552.4411211963693, 1720.7160818464954, 1807.1957978699484, 1855.396995976308, 8293.58532073397, 9102.590383432746, 9308.162265396113, 9766.121049105579, 9804.117629413351, 9326.114019168184, 9780.266480013992, 9782.706518804429, 9792.902070979288, 9809.460479673633, 2497.051120574179, 2533.050106210171, 2533.809964252679, 2534.1510593951048, 2536.5941449368106, 2349.4948586053997, 2420.1650430601503, 2427.635854621812, 2429.9878500607474, 2433.1605596069326, 2510.2092840755104, 2521.6595759572406, 2521.684789401325, 2527.3807917060344, 2536.0236309020975, 2338.251759436981, 2356.175338631482, 2371.9644205336936, 2375.5248950209852, 2376.4296568823356, 2399.748026457214, 2403.399150212447, 2416.516696660675, 2434.9756502434925, 2477.6407420923865, 9590.712278631652, 9687.32188746788, 9700.611975520971, 9735.610575576968, 9840.852387214198, 5706.229658996065, 5844.035734103868, 5844.4739973402175, 5856.267966504187, 5857.76568937242, 3631.110377957391, 3729.869454569104, 3771.453139294787, 3818.274527839729, 3853.0367408147963, 1182.9053675705923, 1211.3398197982121, 1222.4987755020488, 1225.3199474291764, 1246.8940140088102, 13632.0, 13729.176249425067, 13785.586432407044, 13831.100978436369, 13848.861511384857, 5069.239614057847, 5095.949040509548, 5197.1164901966, 5253.212018197224, 5269.55208807248, 10872.61945831892, 10898.400587967579, 10948.671539853816, 10949.397783121845, 10955.287906286067, 5863.413658634187, 5869.178315035899, 5881.411858814085, 5900.527957763368, 5903.822885313448, 4525.592696657317, 5227.660202086852, 5306.336707911511, 5361.624686272002, 5484.643498172606, 3918.9804050979565, 4070.75575465473, 4083.8570650027104, 4085.9182816343505, 4170.998960249518, 1163.8777928317575, 1181.3974872814927, 1182.1665725663386, 1184.0350114656528, 1194.4684615346262, 937.2221056523069, 940.4451373689556, 1020.2246292817364, 1088.548252475214, 1091.6397588795678, 6644.269130395653, 6788.76239331621, 6855.383015528626, 6866.279040700654, 7069.611171385521, 1010.2978429991233, 1075.876274228458, 1113.8886111388958, 1128.3793913347627, 1138.174823253135, 4436.711613745097, 4470.575295346936, 4595.724256544551, 4622.491525932145, 4713.434387873409, 11634.185607007428, 12043.87956120445, 12176.634700958986, 12201.084918631139, 12226.20529665569, 11969.88030119705, 11980.101492388107, 12047.277163370225, 12097.032237420985, 12131.150819442555, 9126.81746365069, 9214.124658157465, 9231.584578693975, 9238.399504032217, 9256.0, 6461.321561236191, 6472.579282346633, 6590.5716128451495, 6650.800475985729, 6669.1330127083165, 11112.333260004425, 11141.331520108819, 11258.324500529994, 11297.887021129683, 11359.432028398713, 10820.513076911715, 11101.94449027782, 11108.61119860801, 11362.431878405881, 11406.885931140583, 8524.190201930807, 8794.340424468062, 8842.955785221033, 8898.0, 8911.019787823463, 9450.243980481682, 9515.429074255568, 9585.616575337188, 9617.615295388106, 9632.614695412105, 8241.752747417588, 8263.917360826556, 8341.749747507585, 8401.663933442594, 8422.284105851071, 8202.876956845532, 8237.50574965504, 8321.12628174033, 8430.241278284984, 8556.443831150955, 7902.367810575255, 7928.801779955547, 7956.681732730857, 7972.840543188988, 7992.680292788224, 5679.74441150141, 5697.943020569741, 5793.044147715748, 5808.883822323445, 5830.82507524775, 5424.1321388577635, 5466.671999680032, 5494.2582751328055, 5569.777208911598, 5613.0], "value": 5060.103609182688, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [324.34806039859876, 333.5197315865155, 336.88040745535335, 343.30994700651684, 344.3165316846059, 5754.33825110112, 5844.678542680151, 5855.916655418745, 5865.0, 5866.472017518422, 5740.110282906146, 5752.137179423078, 5784.710764461771, 5799.0, 5810.041343178371, 4192.538820729717, 4302.419173411597, 4406.383106365095, 4445.0, 4450.755208463534, 4423.159599676067, 4429.247028005231, 4437.1125774844995, 4446.955530444703, 4450.109978004412, 4393.846215382462, 4402.449693788277, 4415.845445409412, 4431.778411079449, 4432.468103827529, 4327.264365057932, 4396.0, 4418.889527761799, 4439.445069366329, 4440.911181776362, 3832.6358995895343, 3841.9231615367535, 3844.038990252437, 3847.633705271238, 3847.7306588538813, 5579.218909352694, 5624.3250809902665, 5630.296212973379, 5637.830865074055, 5655.179998900177, 4858.805647774085, 5053.393592768854, 5089.618278629117, 5128.820491282824, 5134.845954621367, 6052.485538729169, 6064.757409703607, 6113.908291375588, 6116.776644671084, 6119.785807496761, 4231.788410579458, 4242.787860606957, 4264.9147017059795, 4274.935875961863, 4275.40144379787, 6132.141500189977, 6317.0, 6320.367963203689, 6342.270638876542, 6355.809325720235, 4335.501417336984, 4340.634354276926, 4341.3487976803735, 4356.281213599784, 4358.825646974085, 4408.0, 4419.469663640384, 4420.955790442119, 4425.782909699794, 4432.3794668746405, 4783.378160839138, 5042.9747851261245, 5100.642954993189, 5101.923471147936, 5126.461721519261, 6130.620610362722, 6139.754409823647, 6142.662153581596, 6166.969165154145, 6167.444929956326, 1463.8609332113433, 1493.0, 1508.2383396384755, 1513.9243037848064, 1519.574519134644, 894.3784070071238, 918.8621706744042, 948.4735971535725, 956.5791051937125, 1045.8692663417073, 5876.236089308362, 5900.9999999999145, 5921.792737254175, 5938.930992421406, 5943.138244954457, 6170.192562384104, 6178.227721534809, 6208.410201030895, 6223.906641400383, 6231.470325022333, 5678.801241956512, 5936.287645482484, 5957.404259574095, 5991.430814072656, 6010.398960103955, 3351.312980838922, 3354.765166438326, 3363.9327213455595, 3367.6463971282665, 3379.341028499419, 6321.810345689637, 6418.935810641927, 6473.190851143607, 6489.643069631121, 6548.1814773153355, 6332.258628877095, 6339.11252424661, 6341.0, 6361.791259660649, 6421.454176395058, 6377.585456945284, 6398.208501619554, 6520.347965203537, 6529.608223506605, 6538.934610653928, 6294.181756371642, 6323.557350985387, 6344.555881088279, 6351.68241587928, 6359.0, 6210.689465526615, 6213.65824879636, 6222.657753823402, 6237.781677641261, 6237.937620623736, 6305.274893387319, 6465.676716164267, 6485.156929599122, 6487.578307410004, 6529.7061632227615, 4395.933911061796, 4418.668599854959, 4419.381286619811, 4424.75663838492, 4436.3123715824095, 6166.938330616636, 6313.305536391085, 6350.142730731477, 6380.457661098859, 6381.936180638134, 6189.721462534107, 6229.813105606839, 6239.285910628891, 6240.625562466266, 6245.437910588069, 6044.90932636002, 6103.176071230505, 6191.566590338633, 6220.626762394271, 6225.470834979077, 5949.732262048132, 6093.786717464867, 6123.84690382744, 6143.754249829957, 6187.0, 6181.412765787243, 6219.160413344141, 6226.221722284715, 6229.657368844757, 6281.937180628135, 5880.558958078247, 5997.790077347272, 6053.909191362045, 6055.182550355822, 6084.630958034407], "value": 4610.177671340478, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [735.8491509240606, 789.0294937227214, 832.2177153475733, 832.7002279179494, 941.4351389166499, 16811.159442027896, 17558.122093895287, 18065.0, 18086.186121624527, 18130.818691813078, 16166.75749863753, 16299.185040747945, 16375.0, 16404.261808218627, 16444.42444514442, 868.8783570300163, 874.7987962768551, 883.1036497954581, 890.6259371064136, 890.7951171230588, 871.2811930157613, 873.1617647058799, 874.7069731639876, 876.7808047988003, 878.8593824987971, 917.9954100229489, 921.7326975177191, 922.524899676667, 923.7782932096283, 929.549168653206, 919.0946917286467, 919.595378033663, 920.4937284493569, 920.5949382271779, 922.0088404964656, 678.4233401608642, 681.1995904811876, 681.2744427185032, 683.0164563029222, 685.0, 17128.057956812372, 17131.314747410088, 17154.0, 17210.82789172105, 17252.13739313029, 14451.349689264009, 14729.852701472955, 14869.03351282174, 15105.773413398698, 15146.697066058618, 14746.926265368604, 14868.553943381716, 15042.623934401618, 15162.0, 15456.381744730197, 4661.254199328091, 4679.74261415622, 4776.188048031808, 4792.353032340624, 4827.831025914076, 78498.6075069621, 78526.0, 86345.56827215887, 89809.10190898138, 92815.53592232063, 12463.127581069419, 12563.874361256454, 12639.494420223273, 12642.873571264354, 12669.619911402673, 22350.66474002891, 22413.887930560242, 22575.0969961203, 22596.322110336718, 22713.318600441682, 9337.11297426757, 9348.57931393089, 9361.297902657328, 9391.859122113174, 9394.201492873046, 5189.922151167735, 5191.065608190486, 5245.318108645928, 5315.521603055744, 5439.456054394608, 3942.586028467027, 4019.8593049243136, 4027.476428064333, 4052.412400202013, 4060.6954478414236, 689.5001124185026, 696.7526528082458, 699.9615021173885, 702.0907924238124, 713.5219403000002, 616.0194973161308, 693.1197379328225, 719.4999475364676, 719.6689522819457, 720.2077714514097, 10188.337758045704, 10190.344358880744, 10460.738481538023, 10798.460076996118, 11039.448027598588, 680.3502654964497, 701.6246308225075, 741.3179874515458, 749.4969570225779, 758.6775620361325, 5066.847994560169, 5099.719515426687, 5200.61789519552, 5356.116240820299, 5408.296921400193, 78536.60731696419, 109124.4543777276, 116594.0, 139148.3042584801, 145804.27097864443, 121747.0, 122744.0, 124954.0, 127286.0, 127343.0, 76540.61729691428, 88773.0, 90668.54665726761, 91576.54211728899, 93910.53044734732, 10486.0, 10503.842442363219, 10522.421266830397, 10578.8413173804, 10709.250352475252, 55568.0, 56709.0, 56879.44042518014, 57666.42333576611, 58689.70655146697, 75096.0, 75767.62116189604, 83948.0, 86465.13534864571, 87462.56268718616, 13536.526221582197, 13601.0, 13755.0, 13944.16335019902, 14296.356663949939, 15625.84374156244, 15893.602659933595, 15952.361905523649, 16230.0, 16507.58731031734, 14659.267036648338, 15021.549353518974, 15035.0, 15084.924575377492, 15515.069095854285, 14406.567802965928, 15454.84545154579, 15556.611084722972, 15822.762658560361, 15825.920870396036, 14687.55937321882, 14711.55865324042, 14791.186484743443, 14820.40718371253, 15749.0, 12180.75638487243, 12216.26702397859, 12574.559890403792, 12735.108542401942, 12855.935720321339, 12437.440315186019, 12481.56314528987, 12611.93694031524, 12822.807657885325, 12881.291528965998], "value": 8337.036030686215, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1495.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 109.0, 103.0, 111.0, 109.0, 111.0, 97.0, 113.0, 109.0, 109.0], "value": 107.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 116.0, 146.0, 171.0, 119.0, 147.0, 142.0, 122.0, 180.0, 116.0], "value": 140.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 165.0, 162.0, 164.0, 163.0, 163.0, 162.0, 162.0, 161.0, 162.0], "value": 162.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 186.0, 76.0, 76.0, 76.0, 76.0, 164.0, 77.0], "value": 95.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 148.0, 85.0, 84.0, 85.0, 131.0, 86.0, 84.0, 138.0], "value": 101.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 118.0, 117.0, 117.0, 118.0, 118.0, 118.0, 118.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 146.0, 147.0, 146.0, 146.0, 146.0, 147.0, 146.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 98.0, 95.0, 96.0, 95.0, 94.0, 96.0, 96.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 52.0, 52.0, 53.0, 54.0, 54.0, 53.0, 52.0, 52.0, 53.0], "value": 53.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 58.0, 58.0, 62.0, 58.0, 59.0, 59.0, 60.0, 59.0], "value": 58.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 81.0, 74.0, 72.0, 73.0, 73.0, 74.0, 72.0, 72.0, 73.0], "value": 73.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 119.0, 120.0, 130.0, 132.0, 126.0, 117.0, 116.0, 156.0, 116.0], "value": 125.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 152.0, 158.0, 154.0, 154.0, 158.0, 153.0, 153.0, 156.0, 152.0], "value": 154.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 63.0, 64.0, 61.0, 62.0, 62.0, 62.0, 62.0, 64.0], "value": 62.7, "unit": "score"}]}]} 04:12:16 INFO - Return code: 0 04:12:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:12:16 ERROR - # TBPL SUCCESS # 04:12:16 INFO - Running post-action listener: _resource_record_post_action 04:12:16 INFO - [mozharness: 2016-09-14 11:12:16.714632Z] Finished run-tests step (success) 04:12:16 INFO - Running post-run listener: _resource_record_post_run 04:12:16 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 327901184; Read time: 16; Write time: 265044 04:12:16 INFO - TinderboxPrint: CPU usage
13.2% 04:12:16 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 04:12:16 INFO - TinderboxPrint: I/O write bytes / time
327,901,184 / 265,044 04:12:16 INFO - TinderboxPrint: CPU idle
8,231.5 (86.8%) 04:12:16 INFO - TinderboxPrint: CPU user
1,197.4 (12.6%) 04:12:16 INFO - TinderboxPrint: Swap in / out
0 / 0 04:12:16 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 77471744; Read time: 0; Write time: 96548 04:12:16 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 248246272; Read time: 0; Write time: 168356 04:12:17 INFO - Running post-run listener: _upload_blobber_files 04:12:17 INFO - Blob upload gear active. 04:12:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:12:17 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:12:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:12:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:12:17 INFO - (blobuploader) - INFO - Open directory for files ... 04:12:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:12:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:12:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:12:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:12:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:12:18 INFO - (blobuploader) - INFO - Done attempting. 04:12:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:12:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:12:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:12:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:12:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:12:23 INFO - (blobuploader) - INFO - Done attempting. 04:12:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:12:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:12:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:12:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:12:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:12:25 INFO - (blobuploader) - INFO - Done attempting. 04:12:25 INFO - (blobuploader) - INFO - Iteration through files over. 04:12:25 INFO - Return code: 0 04:12:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:12:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:12:25 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/51a272dd6110b7cdb88d481f035f51bb3f4cda95e9a6f192b6b67101a6ebb7958a9334df3eb1482ac7775edbb916a4e33e1b70c6a044034ea760575914e9991f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b2baadde76cabcf9927f7fe68d328d75582c0a3572ce344fc89622b30562c5451dda03f4a73a4c24c9ba4aca561048ab8f89082c06ebdb145e4d3eb6693c229e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/714d35de6704cc55e286f5104227d9164029b251e1b5dc982daef7452ef5be9cff2749173b7562d81325add5622190a5e8f4a604f68760da86ac284ee2fc52d7"} 04:12:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:12:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:12:25 INFO - Contents: 04:12:25 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/51a272dd6110b7cdb88d481f035f51bb3f4cda95e9a6f192b6b67101a6ebb7958a9334df3eb1482ac7775edbb916a4e33e1b70c6a044034ea760575914e9991f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b2baadde76cabcf9927f7fe68d328d75582c0a3572ce344fc89622b30562c5451dda03f4a73a4c24c9ba4aca561048ab8f89082c06ebdb145e4d3eb6693c229e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/714d35de6704cc55e286f5104227d9164029b251e1b5dc982daef7452ef5be9cff2749173b7562d81325add5622190a5e8f4a604f68760da86ac284ee2fc52d7"} 04:12:25 INFO - Running post-run listener: copy_logs_to_upload_dir 04:12:25 INFO - Copying logs to upload dir... 04:12:25 INFO - mkdir: /builds/slave/test/build/upload/logs 04:12:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1678.662969 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 58 secs) (at 2016-09-14 04:12:24.774172) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-14 04:12:24.779451) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41a7e32711b8e08598a63237000001d6-1473849864.248523-1632268604 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/51a272dd6110b7cdb88d481f035f51bb3f4cda95e9a6f192b6b67101a6ebb7958a9334df3eb1482ac7775edbb916a4e33e1b70c6a044034ea760575914e9991f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b2baadde76cabcf9927f7fe68d328d75582c0a3572ce344fc89622b30562c5451dda03f4a73a4c24c9ba4aca561048ab8f89082c06ebdb145e4d3eb6693c229e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/714d35de6704cc55e286f5104227d9164029b251e1b5dc982daef7452ef5be9cff2749173b7562d81325add5622190a5e8f4a604f68760da86ac284ee2fc52d7"} build_url:https://queue.taskcluster.net/v1/task/Rp6e7ySwSWqdPvDsHr_9Jg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011419 build_url: 'https://queue.taskcluster.net/v1/task/Rp6e7ySwSWqdPvDsHr_9Jg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/51a272dd6110b7cdb88d481f035f51bb3f4cda95e9a6f192b6b67101a6ebb7958a9334df3eb1482ac7775edbb916a4e33e1b70c6a044034ea760575914e9991f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b2baadde76cabcf9927f7fe68d328d75582c0a3572ce344fc89622b30562c5451dda03f4a73a4c24c9ba4aca561048ab8f89082c06ebdb145e4d3eb6693c229e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/714d35de6704cc55e286f5104227d9164029b251e1b5dc982daef7452ef5be9cff2749173b7562d81325add5622190a5e8f4a604f68760da86ac284ee2fc52d7"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-14 04:12:24.804795) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-14 04:12:24.805144) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41a7e32711b8e08598a63237000001d6-1473849864.248523-1632268604 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004446 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-14 04:12:24.888814) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-14 04:12:24.889152) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-14 04:12:24.889470) ========= ========= Total master_lag: 0.16 =========