builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-051 starttime: 1471048062.33 results: success (0) buildid: 20160812152716 builduid: b7a4ce95e34e40a2bd78b40604882bb1 revision: 50153501e96e8cb48d63f09c83ace1a129f3fa73 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-12 17:27:42.333129) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-12 17:27:42.333672) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-12 17:27:42.333965) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-12 17:27:42.349961) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 17:27:42.350244) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1471048061.579866-1675508048 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-12 17:27:42-- 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% 28.9M=0s 2016-08-12 17:27:42 (28.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.098151 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 17:27:42.462300) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 17:27:42.462613) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1471048061.579866-1675508048 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018637 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 17:27:42.512025) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-12 17:27:42.512411) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 50153501e96e8cb48d63f09c83ace1a129f3fa73 --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 50153501e96e8cb48d63f09c83ace1a129f3fa73 --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=5ac5dba3e01a12f1ff77ab15000001b1-1471048061.579866-1675508048 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-12 17:27:42,553 truncating revision to first 12 chars 2016-08-12 17:27:42,553 Setting DEBUG logging. 2016-08-12 17:27:42,553 attempt 1/10 2016-08-12 17:27:42,553 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/50153501e96e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-12 17:27:43,819 unpacking tar archive at: mozilla-aurora-50153501e96e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.659699 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-12 17:27:44.186256) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-12 17:27:44.186596) ========= script_repo_revision: 50153501e96e8cb48d63f09c83ace1a129f3fa73 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-12 17:27:44.186990) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-12 17:27:44.187268) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-12 17:27:44.196910) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 28 mins, 4 secs) (at 2016-08-12 17:27:44.197248) ========= /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=5ac5dba3e01a12f1ff77ab15000001b1-1471048061.579866-1675508048 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:27:44 INFO - MultiFileLogger online at 20160812 17:27:44 in /builds/slave/test 17:27:44 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 17:27:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:27:44 INFO - {'append_to_log': False, 17:27:44 INFO - 'base_work_dir': '/builds/slave/test', 17:27:44 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 17:27:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:27:44 INFO - 'branch': 'Mozilla-Aurora', 17:27:44 INFO - 'buildbot_json_path': 'buildprops.json', 17:27:44 INFO - 'config_files': ('talos/linux_config.py',), 17:27:44 INFO - 'default_actions': ('clobber', 17:27:44 INFO - 'read-buildbot-config', 17:27:44 INFO - 'download-and-extract', 17:27:44 INFO - 'populate-webroot', 17:27:44 INFO - 'create-virtualenv', 17:27:44 INFO - 'install', 17:27:44 INFO - 'run-tests'), 17:27:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:27:44 INFO - 'download_minidump_stackwalk': True, 17:27:44 INFO - 'download_symbols': 'ondemand', 17:27:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:27:44 INFO - 'tooltool.py': '/tools/tooltool.py', 17:27:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:27:44 INFO - '/tools/misc-python/virtualenv.py')}, 17:27:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:27:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:27:44 INFO - 'installer_path': 'installer.exe', 17:27:44 INFO - 'log_level': 'info', 17:27:44 INFO - 'log_name': 'talos', 17:27:44 INFO - 'log_to_console': True, 17:27:44 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:27:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:27:44 INFO - 'opt_config_files': (), 17:27:44 INFO - 'pip_index': False, 17:27:44 INFO - 'sps_profile': False, 17:27:44 INFO - 'sps_profile_interval': 0, 17:27:44 INFO - 'suite': 'dromaeojs-e10s', 17:27:44 INFO - 'system_bits': '32', 17:27:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:27:44 INFO - 'title': 'talos-linux64-ix-051', 17:27:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:27:44 INFO - 'use_talos_json': True, 17:27:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:27:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:27:44 INFO - 'work_dir': 'build'} 17:27:44 INFO - [mozharness: 2016-08-13 00:27:44.330255Z] Running clobber step. 17:27:44 INFO - Running pre-action listener: _resource_record_pre_action 17:27:44 INFO - Running main action method: clobber 17:27:44 INFO - rmtree: /builds/slave/test/build 17:27:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:27:44 INFO - Running post-action listener: _resource_record_post_action 17:27:44 INFO - [mozharness: 2016-08-13 00:27:44.772204Z] Finished clobber step (success) 17:27:44 INFO - [mozharness: 2016-08-13 00:27:44.772306Z] Running read-buildbot-config step. 17:27:44 INFO - Running pre-action listener: _resource_record_pre_action 17:27:44 INFO - Running main action method: read_buildbot_config 17:27:44 INFO - Using buildbot properties: 17:27:44 INFO - { 17:27:44 INFO - "project": "", 17:27:44 INFO - "product": "firefox", 17:27:44 INFO - "script_repo_revision": "production", 17:27:44 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 17:27:44 INFO - "repository": "", 17:27:44 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 17:27:44 INFO - "buildid": "20160812152716", 17:27:44 INFO - "pgo_build": "True", 17:27:44 INFO - "basedir": "/builds/slave/test", 17:27:44 INFO - "buildnumber": 456, 17:27:44 INFO - "slavename": "talos-linux64-ix-051", 17:27:44 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 17:27:44 INFO - "platform": "ubuntu64_hw", 17:27:44 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 17:27:44 INFO - "branch": "mozilla-aurora", 17:27:44 INFO - "repo_path": "releases/mozilla-aurora", 17:27:44 INFO - "revision": "50153501e96e8cb48d63f09c83ace1a129f3fa73", 17:27:44 INFO - "stage_platform": "linux64-pgo", 17:27:44 INFO - "builduid": "b7a4ce95e34e40a2bd78b40604882bb1", 17:27:44 INFO - "slavebuilddir": "test" 17:27:44 INFO - } 17:27:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/F8jmALBQR2S2st2MIcys-A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2. 17:27:44 INFO - Running post-action listener: _resource_record_post_action 17:27:44 INFO - [mozharness: 2016-08-13 00:27:44.774745Z] Finished read-buildbot-config step (success) 17:27:44 INFO - [mozharness: 2016-08-13 00:27:44.774834Z] Running download-and-extract step. 17:27:44 INFO - Running pre-action listener: _resource_record_pre_action 17:27:44 INFO - Running main action method: download_and_extract 17:27:44 INFO - mkdir: /builds/slave/test/build/tests 17:27:44 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')]} 17:27:44 INFO - https://queue.taskcluster.net/v1/task/F8jmALBQR2S2st2MIcys-A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:27:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F8jmALBQR2S2st2MIcys-A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 17:27:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F8jmALBQR2S2st2MIcys-A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 17:27:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F8jmALBQR2S2st2MIcys-A/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 17:27:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F8jmALBQR2S2st2MIcys-A/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 17:27:44 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F8jmALBQR2S2st2MIcys-A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 17:27:44 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 17:27:44 INFO - retry: Failed, sleeping 30 seconds before retrying 17:28:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F8jmALBQR2S2st2MIcys-A/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 17:28:14 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F8jmALBQR2S2st2MIcys-A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 17:28:14 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 17:28:14 INFO - retry: Failed, sleeping 60 seconds before retrying 17:29:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F8jmALBQR2S2st2MIcys-A/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 17:29:14 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F8jmALBQR2S2st2MIcys-A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 17:29:14 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 17:29:14 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F8jmALBQR2S2st2MIcys-A/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! 17:29:14 INFO - Caught exception: HTTP Error 404: Not Found 17:29:14 INFO - Caught exception: HTTP Error 404: Not Found 17:29:14 INFO - Caught exception: HTTP Error 404: Not Found 17:29:14 INFO - trying https://queue.taskcluster.net/v1/task/F8jmALBQR2S2st2MIcys-A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 17:29:14 INFO - Downloading https://queue.taskcluster.net/v1/task/F8jmALBQR2S2st2MIcys-A/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 17:29:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/F8jmALBQR2S2st2MIcys-A/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 17:29:15 INFO - Downloaded 1361 bytes. 17:29:15 INFO - Reading from file /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 17:29:15 INFO - Using the following test package requirements: 17:29:15 INFO - {u'common': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 17:29:15 INFO - u'cppunittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 17:29:15 INFO - u'firefox-50.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 17:29:15 INFO - u'gtest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 17:29:15 INFO - u'firefox-50.0a2.en-US.linux-x86_64.gtest.tests.zip'], 17:29:15 INFO - u'jittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 17:29:15 INFO - u'jsshell-linux-x86_64.zip'], 17:29:15 INFO - u'mochitest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 17:29:15 INFO - u'firefox-50.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 17:29:15 INFO - u'mozbase': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 17:29:15 INFO - u'reftest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 17:29:15 INFO - u'firefox-50.0a2.en-US.linux-x86_64.reftest.tests.zip'], 17:29:15 INFO - u'talos': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 17:29:15 INFO - u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'], 17:29:15 INFO - u'web-platform': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 17:29:15 INFO - u'firefox-50.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 17:29:15 INFO - u'xpcshell': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 17:29:15 INFO - u'firefox-50.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 17:29:15 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:29:15 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')]} 17:29:15 INFO - https://queue.taskcluster.net/v1/task/F8jmALBQR2S2st2MIcys-A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:29:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F8jmALBQR2S2st2MIcys-A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 17:29:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F8jmALBQR2S2st2MIcys-A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 17:29:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F8jmALBQR2S2st2MIcys-A/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 17:29:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F8jmALBQR2S2st2MIcys-A/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 17:29:15 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F8jmALBQR2S2st2MIcys-A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 17:29:15 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 17:29:15 INFO - retry: Failed, sleeping 30 seconds before retrying 17:29:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F8jmALBQR2S2st2MIcys-A/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 17:29:45 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F8jmALBQR2S2st2MIcys-A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 17:29:45 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 17:29:45 INFO - retry: Failed, sleeping 60 seconds before retrying 17:30:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F8jmALBQR2S2st2MIcys-A/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 17:30:45 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F8jmALBQR2S2st2MIcys-A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 17:30:45 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 17:30:45 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F8jmALBQR2S2st2MIcys-A/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! 17:30:45 INFO - Caught exception: HTTP Error 404: Not Found 17:30:45 INFO - Caught exception: HTTP Error 404: Not Found 17:30:45 INFO - Caught exception: HTTP Error 404: Not Found 17:30:45 INFO - trying https://queue.taskcluster.net/v1/task/F8jmALBQR2S2st2MIcys-A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 17:30:45 INFO - Downloading https://queue.taskcluster.net/v1/task/F8jmALBQR2S2st2MIcys-A/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 17:30:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/F8jmALBQR2S2st2MIcys-A/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 17:30:46 INFO - Downloaded 21765249 bytes. 17:30:46 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'] 17:30:46 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 17:30:47 INFO - Return code: 0 17:30:47 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 17:30:47 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')]} 17:30:47 INFO - https://queue.taskcluster.net/v1/task/F8jmALBQR2S2st2MIcys-A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:30:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F8jmALBQR2S2st2MIcys-A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 17:30:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F8jmALBQR2S2st2MIcys-A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 17:30:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F8jmALBQR2S2st2MIcys-A/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 17:30:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F8jmALBQR2S2st2MIcys-A/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 17:30:47 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F8jmALBQR2S2st2MIcys-A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 17:30:47 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 17:30:47 INFO - retry: Failed, sleeping 30 seconds before retrying 17:31:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F8jmALBQR2S2st2MIcys-A/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 17:31:17 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F8jmALBQR2S2st2MIcys-A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 17:31:17 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 17:31:17 INFO - retry: Failed, sleeping 60 seconds before retrying 17:32:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F8jmALBQR2S2st2MIcys-A/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 17:32:17 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F8jmALBQR2S2st2MIcys-A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 17:32:17 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 17:32:17 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F8jmALBQR2S2st2MIcys-A/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! 17:32:17 INFO - Caught exception: HTTP Error 404: Not Found 17:32:17 INFO - Caught exception: HTTP Error 404: Not Found 17:32:17 INFO - Caught exception: HTTP Error 404: Not Found 17:32:17 INFO - trying https://queue.taskcluster.net/v1/task/F8jmALBQR2S2st2MIcys-A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 17:32:17 INFO - Downloading https://queue.taskcluster.net/v1/task/F8jmALBQR2S2st2MIcys-A/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 17:32:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/F8jmALBQR2S2st2MIcys-A/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 17:32:18 INFO - Downloaded 21765249 bytes. 17:32:18 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'] 17:32:18 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 17:32:19 INFO - Return code: 0 17:32: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')]} 17:32:19 INFO - https://queue.taskcluster.net/v1/task/F8jmALBQR2S2st2MIcys-A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:32:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F8jmALBQR2S2st2MIcys-A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 17:32:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F8jmALBQR2S2st2MIcys-A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 17:32:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F8jmALBQR2S2st2MIcys-A/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 17:32:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F8jmALBQR2S2st2MIcys-A/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 17:32:19 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F8jmALBQR2S2st2MIcys-A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 17:32:19 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 17:32:19 INFO - retry: Failed, sleeping 30 seconds before retrying 17:32:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F8jmALBQR2S2st2MIcys-A/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 17:32:49 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F8jmALBQR2S2st2MIcys-A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 17:32:49 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 17:32:49 INFO - retry: Failed, sleeping 60 seconds before retrying 17:33:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F8jmALBQR2S2st2MIcys-A/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 17:33:50 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F8jmALBQR2S2st2MIcys-A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 17:33:50 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 17:33:50 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F8jmALBQR2S2st2MIcys-A/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! 17:33:50 INFO - Caught exception: HTTP Error 404: Not Found 17:33:50 INFO - Caught exception: HTTP Error 404: Not Found 17:33:50 INFO - Caught exception: HTTP Error 404: Not Found 17:33:50 INFO - trying https://queue.taskcluster.net/v1/task/F8jmALBQR2S2st2MIcys-A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 17:33:50 INFO - Downloading https://queue.taskcluster.net/v1/task/F8jmALBQR2S2st2MIcys-A/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 17:33:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/F8jmALBQR2S2st2MIcys-A/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 17:33:51 INFO - Downloaded 14413723 bytes. 17:33:51 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'] 17:33:51 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 17:33:52 INFO - Return code: 0 17:33:52 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')]} 17:33:52 INFO - https://queue.taskcluster.net/v1/task/F8jmALBQR2S2st2MIcys-A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:33:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F8jmALBQR2S2st2MIcys-A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 17:33:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F8jmALBQR2S2st2MIcys-A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 17:33:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F8jmALBQR2S2st2MIcys-A/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 17:33:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F8jmALBQR2S2st2MIcys-A/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 17:33:52 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F8jmALBQR2S2st2MIcys-A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 17:33:52 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 17:33:52 INFO - retry: Failed, sleeping 30 seconds before retrying 17:34:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F8jmALBQR2S2st2MIcys-A/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 17:34:22 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F8jmALBQR2S2st2MIcys-A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 17:34:22 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 17:34:22 INFO - retry: Failed, sleeping 60 seconds before retrying 17:35:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F8jmALBQR2S2st2MIcys-A/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 17:35:22 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F8jmALBQR2S2st2MIcys-A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 17:35:22 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 17:35:22 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F8jmALBQR2S2st2MIcys-A/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! 17:35:22 INFO - Caught exception: HTTP Error 404: Not Found 17:35:22 INFO - Caught exception: HTTP Error 404: Not Found 17:35:22 INFO - Caught exception: HTTP Error 404: Not Found 17:35:22 INFO - trying https://queue.taskcluster.net/v1/task/F8jmALBQR2S2st2MIcys-A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 17:35:22 INFO - Downloading https://queue.taskcluster.net/v1/task/F8jmALBQR2S2st2MIcys-A/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 17:35:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/F8jmALBQR2S2st2MIcys-A/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 17:35:23 INFO - Downloaded 63756904 bytes. 17:35:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/F8jmALBQR2S2st2MIcys-A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 17:35:23 INFO - mkdir: /builds/slave/test/properties 17:35:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:35:23 INFO - Writing to file /builds/slave/test/properties/build_url 17:35:23 INFO - Contents: 17:35:23 INFO - build_url:https://queue.taskcluster.net/v1/task/F8jmALBQR2S2st2MIcys-A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 17:35:24 INFO - Running post-action listener: _resource_record_post_action 17:35:24 INFO - Running post-action listener: set_extra_try_arguments 17:35:24 INFO - [mozharness: 2016-08-13 00:35:24.123719Z] Finished download-and-extract step (success) 17:35:24 INFO - [mozharness: 2016-08-13 00:35:24.123949Z] Running populate-webroot step. 17:35:24 INFO - Running pre-action listener: _resource_record_pre_action 17:35:24 INFO - Running main action method: populate_webroot 17:35:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:35:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:35:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:35:24 INFO - '--tppagecycles', 17:35:24 INFO - '7'], 17:35:24 INFO - 'tests': ['tsvgm']}}, 17:35:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:35:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:35:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:35:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:35:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:35:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:35:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:35:24 INFO - 'talos_options': ['--disable-e10s'], 17:35:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:35:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:35:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:35:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:35:24 INFO - 'talos_options': ['--disable-e10s'], 17:35:24 INFO - 'tests': ['damp', 'tps']}, 17:35:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:35:24 INFO - 'tests': ['damp', 'tps']}, 17:35:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:35:24 INFO - 'tests': ['dromaeo_dom']}, 17:35:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:35:24 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:35:24 INFO - 'tests': ['basic_compositor_video']}, 17:35:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:35:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:35:24 INFO - 'tests': ['a11yr', 17:35:24 INFO - 'ts_paint', 17:35:24 INFO - 'tpaint', 17:35:24 INFO - 'sessionrestore', 17:35:24 INFO - 'sessionrestore_no_auto_restore', 17:35:24 INFO - 'tabpaint']}, 17:35:24 INFO - 'other-e10s': {'tests': ['a11yr', 17:35:24 INFO - 'ts_paint', 17:35:24 INFO - 'tpaint', 17:35:24 INFO - 'sessionrestore', 17:35:24 INFO - 'sessionrestore_no_auto_restore', 17:35:24 INFO - 'tabpaint']}, 17:35:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:35:24 INFO - 'ts_paint', 17:35:24 INFO - 'tpaint', 17:35:24 INFO - 'sessionrestore', 17:35:24 INFO - 'sessionrestore_no_auto_restore', 17:35:24 INFO - 'tabpaint']}, 17:35:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:35:24 INFO - 'ts_paint', 17:35:24 INFO - 'tpaint', 17:35:24 INFO - 'sessionrestore', 17:35:24 INFO - 'sessionrestore_no_auto_restore', 17:35:24 INFO - 'tabpaint']}, 17:35:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:35:24 INFO - 'tests': ['a11yr', 17:35:24 INFO - 'ts_paint', 17:35:24 INFO - 'tpaint', 17:35:24 INFO - 'sessionrestore', 17:35:24 INFO - 'sessionrestore_no_auto_restore', 17:35:24 INFO - 'tabpaint']}, 17:35:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:35:24 INFO - 'tests': ['a11yr', 17:35:24 INFO - 'ts_paint', 17:35:24 INFO - 'tpaint', 17:35:24 INFO - 'sessionrestore', 17:35:24 INFO - 'sessionrestore_no_auto_restore', 17:35:24 INFO - 'tabpaint']}, 17:35:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:35:24 INFO - 'tests': ['tsvgx', 17:35:24 INFO - 'tsvgr_opacity', 17:35:24 INFO - 'tart', 17:35:24 INFO - 'tscrollx', 17:35:24 INFO - 'cart']}, 17:35:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:35:24 INFO - 'tsvgr_opacity', 17:35:24 INFO - 'tart', 17:35:24 INFO - 'tscrollx', 17:35:24 INFO - 'cart']}, 17:35:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:35:24 INFO - 'talos_options': ['--disable-e10s'], 17:35:24 INFO - 'tests': ['tp5o']}, 17:35:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:35:24 INFO - 'tests': ['tp5o']}, 17:35:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:35:24 INFO - 'talos_options': ['--disable-e10s', 17:35:24 INFO - '--xperf_path', 17:35:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:35:24 INFO - 'tests': ['tp5n']}, 17:35:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:35:24 INFO - 'talos_options': ['--xperf_path', 17:35:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:35:24 INFO - 'tests': ['tp5n']}}, 17:35:24 INFO - 'talos.zip': {'path': '', 17:35:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:35:24 INFO - Running post-action listener: _resource_record_post_action 17:35:24 INFO - [mozharness: 2016-08-13 00:35:24.143178Z] Finished populate-webroot step (success) 17:35:24 INFO - [mozharness: 2016-08-13 00:35:24.143267Z] Running create-virtualenv step. 17:35:24 INFO - Running pre-action listener: _resource_record_pre_action 17:35:24 INFO - Running main action method: create_virtualenv 17:35:24 INFO - Creating virtualenv /builds/slave/test/build/venv 17:35:24 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 17:35:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:35:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:35:24 INFO - Using real prefix '/usr' 17:35:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:35:24 INFO - Installing distribute.............................................................................................................................................................................................done. 17:35:26 INFO - Installing pip.................done. 17:35:26 INFO - Return code: 0 17:35:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:35:26 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')]} 17:35:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:35:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:35:26 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')]} 17:35:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:35:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:35:26 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 0xdb3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe2400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1071570>, '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 0x1072470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1072900>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1471048061.579866-1675508048', '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 17:35:26 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 17:35:26 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 17:35:26 INFO - Using env: {'DISPLAY': ':0', 17:35:26 INFO - 'HOME': '/home/cltbld', 17:35:26 INFO - 'LANG': 'en_US.UTF-8', 17:35:26 INFO - 'LANGUAGE': 'en_US:en', 17:35:26 INFO - 'LOGNAME': 'cltbld', 17:35:26 INFO - 'MAIL': '/var/mail/cltbld', 17:35:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:35:26 INFO - 'MOZ_NO_REMOTE': '1', 17:35:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:35:26 INFO - 'NO_EM_RESTART': '1', 17:35:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:35:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:35:26 INFO - 'PWD': '/builds/slave/test', 17:35:26 INFO - 'SHELL': '/bin/bash', 17:35:26 INFO - 'SHLVL': '1', 17:35:26 INFO - 'TERM': 'linux', 17:35:26 INFO - 'TMOUT': '86400', 17:35:26 INFO - 'USER': 'cltbld', 17:35:26 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1471048061.579866-1675508048', 17:35:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:35:26 INFO - '_': '/tools/buildbot/bin/python'} 17:35:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:35:26 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 17:35:26 INFO - Cleaning up... 17:35:26 INFO - Return code: 0 17:35:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:35:26 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')]} 17:35:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:35:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:35:26 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')]} 17:35:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:35:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:35:26 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 0xdb3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe2400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1071570>, '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 0x1072470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1072900>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1471048061.579866-1675508048', '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 17:35:26 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 17:35:26 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 17:35:26 INFO - Using env: {'DISPLAY': ':0', 17:35:26 INFO - 'HOME': '/home/cltbld', 17:35:26 INFO - 'LANG': 'en_US.UTF-8', 17:35:26 INFO - 'LANGUAGE': 'en_US:en', 17:35:26 INFO - 'LOGNAME': 'cltbld', 17:35:26 INFO - 'MAIL': '/var/mail/cltbld', 17:35:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:35:26 INFO - 'MOZ_NO_REMOTE': '1', 17:35:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:35:26 INFO - 'NO_EM_RESTART': '1', 17:35:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:35:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:35:26 INFO - 'PWD': '/builds/slave/test', 17:35:26 INFO - 'SHELL': '/bin/bash', 17:35:26 INFO - 'SHLVL': '1', 17:35:26 INFO - 'TERM': 'linux', 17:35:26 INFO - 'TMOUT': '86400', 17:35:26 INFO - 'USER': 'cltbld', 17:35:26 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1471048061.579866-1675508048', 17:35:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:35:26 INFO - '_': '/tools/buildbot/bin/python'} 17:35:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:35:27 INFO - Downloading/unpacking psutil>=3.1.1 17:35:27 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 17:35:27 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 17:35:27 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 17:35:27 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 17:35:27 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 17:35:27 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 17:35:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:35:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:35:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:35:29 INFO - Installing collected packages: psutil 17:35:29 INFO - Running setup.py install for psutil 17:35:29 INFO - building 'psutil._psutil_linux' extension 17:35:29 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 17:35:29 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 17:35:29 INFO - building 'psutil._psutil_posix' extension 17:35:29 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 17:35:29 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 17:35:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:35:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:35:29 INFO - Successfully installed psutil 17:35:29 INFO - Cleaning up... 17:35:29 INFO - Return code: 0 17:35:29 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:35: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')]} 17:35:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:35:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:35: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')]} 17:35:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:35:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:35:29 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 0xdb3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe2400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1071570>, '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 0x1072470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1072900>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1471048061.579866-1675508048', '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 17:35:29 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 17:35:29 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 17:35:29 INFO - Using env: {'DISPLAY': ':0', 17:35:29 INFO - 'HOME': '/home/cltbld', 17:35:29 INFO - 'LANG': 'en_US.UTF-8', 17:35:29 INFO - 'LANGUAGE': 'en_US:en', 17:35:29 INFO - 'LOGNAME': 'cltbld', 17:35:29 INFO - 'MAIL': '/var/mail/cltbld', 17:35:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:35:29 INFO - 'MOZ_NO_REMOTE': '1', 17:35:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:35:29 INFO - 'NO_EM_RESTART': '1', 17:35:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:35:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:35:29 INFO - 'PWD': '/builds/slave/test', 17:35:29 INFO - 'SHELL': '/bin/bash', 17:35:29 INFO - 'SHLVL': '1', 17:35:29 INFO - 'TERM': 'linux', 17:35:29 INFO - 'TMOUT': '86400', 17:35:29 INFO - 'USER': 'cltbld', 17:35:29 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1471048061.579866-1675508048', 17:35:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:35:29 INFO - '_': '/tools/buildbot/bin/python'} 17:35:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:35:29 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:35:29 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 17:35:29 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 17:35:29 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 17:35:29 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 17:35:29 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 17:35:29 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 17:35:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:35:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:35:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:35:31 INFO - Installing collected packages: mozsystemmonitor 17:35:31 INFO - Running setup.py install for mozsystemmonitor 17:35:31 INFO - Successfully installed mozsystemmonitor 17:35:31 INFO - Cleaning up... 17:35:31 INFO - Return code: 0 17:35:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:35:31 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')]} 17:35:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:35:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:35:31 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')]} 17:35:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:35:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:35:31 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 0xdb3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe2400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1071570>, '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 0x1072470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1072900>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1471048061.579866-1675508048', '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 17:35:31 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 17:35:31 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 17:35:31 INFO - Using env: {'DISPLAY': ':0', 17:35:31 INFO - 'HOME': '/home/cltbld', 17:35:31 INFO - 'LANG': 'en_US.UTF-8', 17:35:31 INFO - 'LANGUAGE': 'en_US:en', 17:35:31 INFO - 'LOGNAME': 'cltbld', 17:35:31 INFO - 'MAIL': '/var/mail/cltbld', 17:35:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:35:31 INFO - 'MOZ_NO_REMOTE': '1', 17:35:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:35:31 INFO - 'NO_EM_RESTART': '1', 17:35:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:35:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:35:31 INFO - 'PWD': '/builds/slave/test', 17:35:31 INFO - 'SHELL': '/bin/bash', 17:35:31 INFO - 'SHLVL': '1', 17:35:31 INFO - 'TERM': 'linux', 17:35:31 INFO - 'TMOUT': '86400', 17:35:31 INFO - 'USER': 'cltbld', 17:35:31 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1471048061.579866-1675508048', 17:35:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:35:31 INFO - '_': '/tools/buildbot/bin/python'} 17:35:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:35:32 INFO - Downloading/unpacking jsonschema==2.5.1 17:35:32 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 17:35:32 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 17:35:32 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 17:35:32 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 17:35:32 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 17:35:32 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 17:35:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:35:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:35:34 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 17:35:34 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 17:35:34 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 17:35:34 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 17:35:34 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 17:35:34 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 17:35:34 INFO - Downloading functools32-3.2.3-2.tar.gz 17:35:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:35:34 INFO - warning: no files found matching '*.txt' 17:35:34 INFO - no previously-included directories found matching 'build' 17:35:34 INFO - no previously-included directories found matching 'dist' 17:35:34 INFO - no previously-included directories found matching '.git*' 17:35:34 INFO - Installing collected packages: jsonschema, functools32 17:35:34 INFO - Running setup.py install for functools32 17:35:34 INFO - warning: no files found matching '*.txt' 17:35:34 INFO - no previously-included directories found matching 'build' 17:35:34 INFO - no previously-included directories found matching 'dist' 17:35:34 INFO - no previously-included directories found matching '.git*' 17:35:34 INFO - Successfully installed jsonschema functools32 17:35:34 INFO - Cleaning up... 17:35:34 INFO - Return code: 0 17:35:34 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:35:34 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')]} 17:35:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:35:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:35:34 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')]} 17:35:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:35:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:35:34 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 0xdb3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe2400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1071570>, '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 0x1072470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1072900>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1471048061.579866-1675508048', '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 17:35:34 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 17:35:34 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 17:35:34 INFO - Using env: {'DISPLAY': ':0', 17:35:34 INFO - 'HOME': '/home/cltbld', 17:35:34 INFO - 'LANG': 'en_US.UTF-8', 17:35:34 INFO - 'LANGUAGE': 'en_US:en', 17:35:34 INFO - 'LOGNAME': 'cltbld', 17:35:34 INFO - 'MAIL': '/var/mail/cltbld', 17:35:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:35:34 INFO - 'MOZ_NO_REMOTE': '1', 17:35:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:35:34 INFO - 'NO_EM_RESTART': '1', 17:35:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:35:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:35:34 INFO - 'PWD': '/builds/slave/test', 17:35:34 INFO - 'SHELL': '/bin/bash', 17:35:34 INFO - 'SHLVL': '1', 17:35:34 INFO - 'TERM': 'linux', 17:35:34 INFO - 'TMOUT': '86400', 17:35:34 INFO - 'USER': 'cltbld', 17:35:34 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1471048061.579866-1675508048', 17:35:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:35:34 INFO - '_': '/tools/buildbot/bin/python'} 17:35:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:35:34 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:35:34 INFO - Cleaning up... 17:35:34 INFO - Return code: 0 17:35:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:35:34 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')]} 17:35:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:35:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:35:34 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')]} 17:35:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:35:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:35:34 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 0xdb3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe2400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1071570>, '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 0x1072470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1072900>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1471048061.579866-1675508048', '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 17:35:34 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 17:35:34 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 17:35:34 INFO - Using env: {'DISPLAY': ':0', 17:35:34 INFO - 'HOME': '/home/cltbld', 17:35:34 INFO - 'LANG': 'en_US.UTF-8', 17:35:34 INFO - 'LANGUAGE': 'en_US:en', 17:35:34 INFO - 'LOGNAME': 'cltbld', 17:35:34 INFO - 'MAIL': '/var/mail/cltbld', 17:35:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:35:34 INFO - 'MOZ_NO_REMOTE': '1', 17:35:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:35:34 INFO - 'NO_EM_RESTART': '1', 17:35:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:35:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:35:34 INFO - 'PWD': '/builds/slave/test', 17:35:34 INFO - 'SHELL': '/bin/bash', 17:35:34 INFO - 'SHLVL': '1', 17:35:34 INFO - 'TERM': 'linux', 17:35:34 INFO - 'TMOUT': '86400', 17:35:34 INFO - 'USER': 'cltbld', 17:35:34 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1471048061.579866-1675508048', 17:35:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:35:34 INFO - '_': '/tools/buildbot/bin/python'} 17:35:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:35:34 INFO - Downloading/unpacking blobuploader==1.2.4 17:35:34 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 17:35:34 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 17:35:34 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 17:35:34 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 17:35:34 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 17:35:34 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 17:35:36 INFO - Downloading blobuploader-1.2.4.tar.gz 17:35:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:35:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:35:37 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 17:35:37 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 17:35:37 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 17:35:37 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 17:35:37 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 17:35:37 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 17:35:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:35:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:35:37 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 17:35:37 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 17:35:37 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 17:35:37 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 17:35:37 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 17:35:37 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 17:35:37 INFO - Downloading docopt-0.6.1.tar.gz 17:35:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:35:37 INFO - Installing collected packages: blobuploader, requests, docopt 17:35:37 INFO - Running setup.py install for blobuploader 17:35:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:35:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:35:37 INFO - Running setup.py install for requests 17:35:38 INFO - Running setup.py install for docopt 17:35:38 INFO - Successfully installed blobuploader requests docopt 17:35:38 INFO - Cleaning up... 17:35:38 INFO - Return code: 0 17:35:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:35:38 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')]} 17:35:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:35:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:35:38 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')]} 17:35:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:35:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:35:38 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 0xdb3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe2400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1071570>, '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 0x1072470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1072900>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1471048061.579866-1675508048', '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 17:35:38 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 17:35:38 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 17:35:38 INFO - Using env: {'DISPLAY': ':0', 17:35:38 INFO - 'HOME': '/home/cltbld', 17:35:38 INFO - 'LANG': 'en_US.UTF-8', 17:35:38 INFO - 'LANGUAGE': 'en_US:en', 17:35:38 INFO - 'LOGNAME': 'cltbld', 17:35:38 INFO - 'MAIL': '/var/mail/cltbld', 17:35:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:35:38 INFO - 'MOZ_NO_REMOTE': '1', 17:35:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:35:38 INFO - 'NO_EM_RESTART': '1', 17:35:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:35:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:35:38 INFO - 'PWD': '/builds/slave/test', 17:35:38 INFO - 'SHELL': '/bin/bash', 17:35:38 INFO - 'SHLVL': '1', 17:35:38 INFO - 'TERM': 'linux', 17:35:38 INFO - 'TMOUT': '86400', 17:35:38 INFO - 'USER': 'cltbld', 17:35:38 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1471048061.579866-1675508048', 17:35:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:35:38 INFO - '_': '/tools/buildbot/bin/python'} 17:35:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:35:38 INFO - Running setup.py (path:/tmp/pip-UKmFBJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:35:38 INFO - Running setup.py (path:/tmp/pip-1CNHGO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:35:38 INFO - Running setup.py (path:/tmp/pip-1qmq6Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:35:38 INFO - Running setup.py (path:/tmp/pip-dec6X5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:35:38 INFO - Running setup.py (path:/tmp/pip-BARcJx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:35:38 INFO - Running setup.py (path:/tmp/pip-pB3tFy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:35:38 INFO - Running setup.py (path:/tmp/pip-z4DNlK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:35:39 INFO - Running setup.py (path:/tmp/pip-HPSsfA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:35:39 INFO - Running setup.py (path:/tmp/pip-uVSwmO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:35:39 INFO - Running setup.py (path:/tmp/pip-LCCOU9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:35:39 INFO - Running setup.py (path:/tmp/pip-EKjBqD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:35:39 INFO - Running setup.py (path:/tmp/pip-dgPHM6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:35:39 INFO - Running setup.py (path:/tmp/pip-ukLpqm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:35:39 INFO - Running setup.py (path:/tmp/pip-KwEPvx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:35:39 INFO - Running setup.py (path:/tmp/pip-0Lc0uq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:35:39 INFO - Running setup.py (path:/tmp/pip-w7aND7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:35:39 INFO - Running setup.py (path:/tmp/pip-uae_wF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:35:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:35:39 INFO - Running setup.py install for manifestparser 17:35:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:35:39 INFO - Running setup.py install for mozcrash 17:35:39 INFO - Running setup.py install for mozdebug 17:35:40 INFO - Running setup.py install for mozdevice 17:35:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:35:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:35:40 INFO - Running setup.py install for mozfile 17:35:40 INFO - Running setup.py install for mozhttpd 17:35:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:35:40 INFO - Running setup.py install for mozinfo 17:35:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:35:40 INFO - Running setup.py install for mozInstall 17:35:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:35:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:35:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:35:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:35:40 INFO - Running setup.py install for mozleak 17:35:40 INFO - Running setup.py install for mozlog 17:35:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:35:40 INFO - Running setup.py install for moznetwork 17:35:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:35:40 INFO - Running setup.py install for mozprocess 17:35:40 INFO - Running setup.py install for mozprofile 17:35:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:35:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:35:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:35:41 INFO - Running setup.py install for mozrunner 17:35:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:35:41 INFO - Running setup.py install for mozscreenshot 17:35:41 INFO - Running setup.py install for moztest 17:35:41 INFO - Running setup.py install for mozversion 17:35:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:35:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:35:41 INFO - Cleaning up... 17:35:41 INFO - Return code: 0 17:35:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:35:41 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')]} 17:35:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:35:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:35:41 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')]} 17:35:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:35:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:35:41 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 0xdb3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe2400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1071570>, '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 0x1072470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1072900>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1471048061.579866-1675508048', '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 17:35:41 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 17:35:41 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 17:35:41 INFO - Using env: {'DISPLAY': ':0', 17:35:41 INFO - 'HOME': '/home/cltbld', 17:35:41 INFO - 'LANG': 'en_US.UTF-8', 17:35:41 INFO - 'LANGUAGE': 'en_US:en', 17:35:41 INFO - 'LOGNAME': 'cltbld', 17:35:41 INFO - 'MAIL': '/var/mail/cltbld', 17:35:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:35:41 INFO - 'MOZ_NO_REMOTE': '1', 17:35:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:35:41 INFO - 'NO_EM_RESTART': '1', 17:35:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:35:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:35:41 INFO - 'PWD': '/builds/slave/test', 17:35:41 INFO - 'SHELL': '/bin/bash', 17:35:41 INFO - 'SHLVL': '1', 17:35:41 INFO - 'TERM': 'linux', 17:35:41 INFO - 'TMOUT': '86400', 17:35:41 INFO - 'USER': 'cltbld', 17:35:41 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1471048061.579866-1675508048', 17:35:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:35:41 INFO - '_': '/tools/buildbot/bin/python'} 17:35:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:35:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:35:41 INFO - Running setup.py (path:/tmp/pip-HJwSZR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:35:41 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)) 17:35:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:35:41 INFO - Running setup.py (path:/tmp/pip-j1_nob-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:35:41 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)) 17:35:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:35:41 INFO - Running setup.py (path:/tmp/pip-fBARzP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:35:41 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)) 17:35:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:35:42 INFO - Running setup.py (path:/tmp/pip-E4DoaB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:35:42 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)) 17:35:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:35:42 INFO - Running setup.py (path:/tmp/pip-G83UIJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:35:42 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)) 17:35:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:35:42 INFO - Running setup.py (path:/tmp/pip-Yulx2Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:35:42 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)) 17:35:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:35:42 INFO - Running setup.py (path:/tmp/pip-w3WKFc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:35:42 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)) 17:35:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:35:42 INFO - Running setup.py (path:/tmp/pip-oIeeFb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:35:42 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)) 17:35:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:35:42 INFO - Running setup.py (path:/tmp/pip-Aid1ty-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:35:42 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)) 17:35:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:35:42 INFO - Running setup.py (path:/tmp/pip-xTvVN3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:35:42 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)) 17:35:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:35:42 INFO - Running setup.py (path:/tmp/pip-dTLX4K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:35:42 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)) 17:35:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:35:42 INFO - Running setup.py (path:/tmp/pip-TlrsX1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:35:42 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)) 17:35:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:35:42 INFO - Running setup.py (path:/tmp/pip-pJn8aq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:35:42 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)) 17:35:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:35:42 INFO - Running setup.py (path:/tmp/pip-lwzaav-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:35:42 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)) 17:35:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:35:42 INFO - Running setup.py (path:/tmp/pip-9o5ShE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:35:42 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)) 17:35:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:35:42 INFO - Running setup.py (path:/tmp/pip-f_fdJf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:35:42 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)) 17:35:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:35:42 INFO - Running setup.py (path:/tmp/pip-vVUerG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:35:43 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)) 17:35:43 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)) 17:35:43 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)) 17:35:43 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)) 17:35:43 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)) 17:35:43 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)) 17:35:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:35:43 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 17:35:43 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 17:35:43 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 17:35:43 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 17:35:43 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 17:35:43 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 17:35:44 INFO - Downloading blessings-1.6.tar.gz 17:35:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:35:44 INFO - Installing collected packages: blessings 17:35:44 INFO - Running setup.py install for blessings 17:35:45 INFO - Successfully installed blessings 17:35:45 INFO - Cleaning up... 17:35:45 INFO - Return code: 0 17:35:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:35:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:35:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:35:45 INFO - Reading from file tmpfile_stdout 17:35:45 INFO - Current package versions: 17:35:45 INFO - argparse == 1.2.1 17:35:45 INFO - blessings == 1.6 17:35:45 INFO - blobuploader == 1.2.4 17:35:45 INFO - docopt == 0.6.1 17:35:45 INFO - functools32 == 3.2.3-2 17:35:45 INFO - jsonschema == 2.5.1 17:35:45 INFO - manifestparser == 1.1 17:35:45 INFO - mozInstall == 1.12 17:35:45 INFO - mozcrash == 0.17 17:35:45 INFO - mozdebug == 0.1 17:35:45 INFO - mozdevice == 0.48 17:35:45 INFO - mozfile == 1.2 17:35:45 INFO - mozhttpd == 0.7 17:35:45 INFO - mozinfo == 0.9 17:35:45 INFO - mozleak == 0.1 17:35:45 INFO - mozlog == 3.3 17:35:45 INFO - moznetwork == 0.27 17:35:45 INFO - mozprocess == 0.23 17:35:45 INFO - mozprofile == 0.28 17:35:45 INFO - mozrunner == 6.12 17:35:45 INFO - mozscreenshot == 0.1 17:35:45 INFO - mozsystemmonitor == 0.3 17:35:45 INFO - moztest == 0.7 17:35:45 INFO - mozversion == 1.4 17:35:45 INFO - psutil == 3.1.1 17:35:45 INFO - requests == 1.2.3 17:35:45 INFO - wsgiref == 0.1.2 17:35:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:35:45 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')]} 17:35:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:35:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:35:45 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')]} 17:35:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:35:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:35:45 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 0xdb3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe2400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1071570>, '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 0x1072470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1072900>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1471048061.579866-1675508048', '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 17:35:45 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 17:35:45 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 17:35:45 INFO - Using env: {'DISPLAY': ':0', 17:35:45 INFO - 'HOME': '/home/cltbld', 17:35:45 INFO - 'LANG': 'en_US.UTF-8', 17:35:45 INFO - 'LANGUAGE': 'en_US:en', 17:35:45 INFO - 'LOGNAME': 'cltbld', 17:35:45 INFO - 'MAIL': '/var/mail/cltbld', 17:35:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:35:45 INFO - 'MOZ_NO_REMOTE': '1', 17:35:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:35:45 INFO - 'NO_EM_RESTART': '1', 17:35:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:35:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:35:45 INFO - 'PWD': '/builds/slave/test', 17:35:45 INFO - 'SHELL': '/bin/bash', 17:35:45 INFO - 'SHLVL': '1', 17:35:45 INFO - 'TERM': 'linux', 17:35:45 INFO - 'TMOUT': '86400', 17:35:45 INFO - 'USER': 'cltbld', 17:35:45 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1471048061.579866-1675508048', 17:35:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:35:45 INFO - '_': '/tools/buildbot/bin/python'} 17:35:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:35:45 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)) 17:35:45 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)) 17:35:45 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)) 17:35:45 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)) 17:35:45 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)) 17:35:45 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)) 17:35:45 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)) 17:35:45 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)) 17:35:45 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)) 17:35:45 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)) 17:35:45 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)) 17:35:45 INFO - Cleaning up... 17:35:45 INFO - Return code: 0 17:35:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:35:45 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')]} 17:35:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:35:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:35:45 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')]} 17:35:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:35:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:35:45 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 0xdb3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe2400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1071570>, '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 0x1072470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1072900>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1471048061.579866-1675508048', '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 17:35:45 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 17:35:45 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 17:35:45 INFO - Using env: {'DISPLAY': ':0', 17:35:45 INFO - 'HOME': '/home/cltbld', 17:35:45 INFO - 'LANG': 'en_US.UTF-8', 17:35:45 INFO - 'LANGUAGE': 'en_US:en', 17:35:45 INFO - 'LOGNAME': 'cltbld', 17:35:45 INFO - 'MAIL': '/var/mail/cltbld', 17:35:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:35:45 INFO - 'MOZ_NO_REMOTE': '1', 17:35:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:35:45 INFO - 'NO_EM_RESTART': '1', 17:35:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:35:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:35:45 INFO - 'PWD': '/builds/slave/test', 17:35:45 INFO - 'SHELL': '/bin/bash', 17:35:45 INFO - 'SHLVL': '1', 17:35:45 INFO - 'TERM': 'linux', 17:35:45 INFO - 'TMOUT': '86400', 17:35:45 INFO - 'USER': 'cltbld', 17:35:45 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1471048061.579866-1675508048', 17:35:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:35:45 INFO - '_': '/tools/buildbot/bin/python'} 17:35:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:35:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:35:45 INFO - Cleaning up... 17:35:45 INFO - Return code: 0 17:35:45 INFO - Running post-action listener: _resource_record_post_action 17:35:45 INFO - Running post-action listener: _start_resource_monitoring 17:35:45 INFO - Starting resource monitoring. 17:35:45 INFO - [mozharness: 2016-08-13 00:35:45.843228Z] Finished create-virtualenv step (success) 17:35:45 INFO - [mozharness: 2016-08-13 00:35:45.843700Z] Running install step. 17:35:45 INFO - Running pre-action listener: _resource_record_pre_action 17:35:45 INFO - Running main action method: install 17:35:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:35:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:35:46 INFO - Reading from file tmpfile_stdout 17:35:46 INFO - Detecting whether we're running mozinstall >=1.0... 17:35:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:35:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:35:46 INFO - Reading from file tmpfile_stdout 17:35:46 INFO - Output received: 17:35:46 INFO - Usage: mozinstall [options] installer 17:35:46 INFO - Options: 17:35:46 INFO - -h, --help show this help message and exit 17:35:46 INFO - -d DEST, --destination=DEST 17:35:46 INFO - Directory to install application into. [default: 17:35:46 INFO - "/builds/slave/test"] 17:35:46 INFO - --app=APP Application being installed. [default: firefox] 17:35:46 INFO - mkdir: /builds/slave/test/build/application 17:35:46 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'] 17:35:46 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 17:36:02 INFO - Reading from file tmpfile_stdout 17:36:02 INFO - Output received: 17:36:02 INFO - /builds/slave/test/build/application/firefox/firefox 17:36:02 INFO - Running post-action listener: _resource_record_post_action 17:36:02 INFO - [mozharness: 2016-08-13 00:36:02.117402Z] Finished install step (success) 17:36:02 INFO - [mozharness: 2016-08-13 00:36:02.117689Z] Running run-tests step. 17:36:02 INFO - Running pre-action listener: _resource_record_pre_action 17:36:02 INFO - Running main action method: run_tests 17:36:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:36:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:36:02 INFO - Python 2.7.3 17:36:02 INFO - Return code: 0 17:36:02 INFO - grabbing minidump binary from tooltool 17:36: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')]} 17:36:02 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 0x1071570>, '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 0x1072470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1072900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:36:02 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 17:36:02 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 17:36:02 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 17:36:02 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:36:02 INFO - Return code: 0 17:36:02 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:36:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:36:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:36:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:36:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:36:02 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/F8jmALBQR2S2st2MIcys-A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--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 17:36:02 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/F8jmALBQR2S2st2MIcys-A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-051 --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 17:36:02 INFO - Using env: {'DISPLAY': ':0', 17:36:02 INFO - 'HOME': '/home/cltbld', 17:36:02 INFO - 'LANG': 'en_US.UTF-8', 17:36:02 INFO - 'LANGUAGE': 'en_US:en', 17:36:02 INFO - 'LOGNAME': 'cltbld', 17:36:02 INFO - 'MAIL': '/var/mail/cltbld', 17:36:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:36:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:36:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:36:02 INFO - 'MOZ_NO_REMOTE': '1', 17:36:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:36:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:36:02 INFO - 'NO_EM_RESTART': '1', 17:36:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:36:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:36:02 INFO - 'PWD': '/builds/slave/test', 17:36:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:36:02 INFO - 'SHELL': '/bin/bash', 17:36:02 INFO - 'SHLVL': '1', 17:36:02 INFO - 'TERM': 'linux', 17:36:02 INFO - 'TMOUT': '86400', 17:36:02 INFO - 'USER': 'cltbld', 17:36:02 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1471048061.579866-1675508048', 17:36:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:36:02 INFO - '_': '/tools/buildbot/bin/python'} 17:36:02 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/F8jmALBQR2S2st2MIcys-A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--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 17:36:02 INFO - mozversion application_buildid: 20160812152716 17:36:02 INFO - mozversion application_changeset: 50153501e96e8cb48d63f09c83ace1a129f3fa73 17:36:02 INFO - mozversion application_display_name: FirefoxDeveloperEdition 17:36:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:36:02 INFO - mozversion application_name: Firefox 17:36:02 INFO - mozversion application_remotingname: firefox-dev 17:36:02 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 17:36:02 INFO - mozversion application_vendor: Mozilla 17:36:02 INFO - mozversion application_version: 50.0a2 17:36:02 INFO - mozversion platform_buildid: 20160812152716 17:36:02 INFO - mozversion platform_changeset: 50153501e96e8cb48d63f09c83ace1a129f3fa73 17:36:02 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 17:36:02 INFO - mozversion platform_version: 50.0a2 17:36:02 INFO - using testdate: 1471048562 17:36:02 INFO - actual date: 1471048562 17:36:02 INFO - starting webserver on 'localhost:50362' 17:36:02 INFO - SUITE-START | Running 2 tests 17:36:02 INFO - TEST-START | dromaeo_css 17:36:02 INFO - operating with platform_type : linux_ 17:36:02 INFO - Initialising browser for dromaeo_css test... 17:36:02 INFO - TEST-INFO | started process 3884 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHCWHv3/profile http://localhost:50362/getInfo.html) 17:36:07 INFO - PROCESS | 3884 | __metrics Screen width/height:1600/1200 17:36:07 INFO - PROCESS | 3884 | colorDepth:24 17:36:07 INFO - PROCESS | 3884 | Browser inner width/height: 1024/697 17:36:07 INFO - PROCESS | 3884 | __metrics 17:36:07 ERROR - PROCESS | 3884 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 17:36:08 INFO - TEST-INFO | 3884: exit 0 17:36:08 INFO - Browser initialized. 17:36:08 INFO - Running cycle 1/1 for dromaeo_css test... 17:36:08 INFO - TEST-INFO | started process 4010 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHCWHv3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:36:20 INFO - PROCESS | 4010 | RSS: Main: 152297472 17:36:20 INFO - PROCESS | 4010 | 17:37:10 INFO - PROCESS | 4010 | 1471048630078 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] 17:39:18 INFO - PROCESS | 4010 | Cycle 1(1): loaded http://localhost:50362/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50362/tests/dromaeo/cssquery-ext.html) 17:39:19 INFO - PROCESS | 4010 | RSS: Main: 157777920 17:39:19 INFO - PROCESS | 4010 | 17:42:21 INFO - PROCESS | 4010 | Cycle 1(1): loaded http://localhost:50362/tests/dromaeo/cssquery-ext.html (next: http://localhost:50362/tests/dromaeo/cssquery-jquery.html) 17:42:22 INFO - PROCESS | 4010 | RSS: Main: 153804800 17:42:22 INFO - PROCESS | 4010 | 17:45:24 INFO - PROCESS | 4010 | Cycle 1(1): loaded http://localhost:50362/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50362/tests/dromaeo/cssquery-mootools.html) 17:45:24 INFO - PROCESS | 4010 | RSS: Main: 154124288 17:45:24 INFO - PROCESS | 4010 | 17:48:26 INFO - PROCESS | 4010 | Cycle 1(1): loaded http://localhost:50362/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50362/tests/dromaeo/cssquery-prototype.html) 17:48:27 INFO - PROCESS | 4010 | RSS: Main: 151719936 17:48:27 INFO - PROCESS | 4010 | 17:51:29 INFO - PROCESS | 4010 | Cycle 1(1): loaded http://localhost:50362/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50362/tests/dromaeo/cssquery-yui.html) 17:51:30 INFO - PROCESS | 4010 | RSS: Main: 154763264 17:51:30 INFO - PROCESS | 4010 | 17:54:32 INFO - PROCESS | 4010 | Cycle 1(1): loaded http://localhost:50362/tests/dromaeo/cssquery-yui.html (next: http://localhost:50362/tests/dromaeo/cssquery-dojo.html) 17:54:32 INFO - PROCESS | 4010 | RSS: Main: 156221440 17:54:32 INFO - PROCESS | 4010 | 17:54:32 INFO - PROCESS | 4010 | __start_tp_report 17:54:32 INFO - PROCESS | 4010 | _x_x_mozilla_page_load 17:54:32 INFO - PROCESS | 4010 | _x_x_mozilla_page_load_details 17:54:32 INFO - PROCESS | 4010 | |i|pagename|runs| 17:54:32 INFO - PROCESS | 4010 | |0;dojo.html;3372.7301815854735;3397.5922889253293;3408.0287118171327;3413.23202279487;3426.948595771062;5835.416458354162;5839.0949402842525;5931.614445061068;5934.821955341341;5938.1389698493695;5869.677167755772;5926.1110833374905;5930.199423077883;5933.673647949361;5940.04959206527;5304.867378315535;5337.092694241969;5394.514493695567;5403.675779453245;5435.972820135894;5186.92219616706;5200.271961925334;5206.193040078775;5227.686338819683;5236.109861323565;5331.2269720890445;5339.252504649352;5343.786248550054;5352.437994010612;5387.865303367408;5358.115910874721;5367.651102678314;5388.78444862205;5394.6493477924205;5411.134218525017;5091.134507133759;5108.948910510884;5200.635955483118;5282.181261904411;5367.865803354908;5655.4910058094965;5707.6290041147195;5725.227094342294;5740.942590574083;5758.79844205455;6123.050927106306;6147.047207682772;6165.290991535986;6173.567850250484;6196.504279657616;5998.010328295826;6153.569250152491;6224.533160013018;6224.595401298946;6228.190335256433;5779.393163717791;5887.882242355129;5891.764329426818;5908.113782932594;5922.58541902067;6412.5190610704385;6443.323451037667;6455.193100862392;6456.677166141674;6460.095586617877;5957.940420595739;6072.787452439144;6107.389261073946;6175.042868355412;6183.721732522047;6169.691515424211;6249.6875156242;6279.529035322369;6287.748490060347;6295.464885484694;6243.843903902439;6250.218722659668;6253.405926436982;6254.843628909313;6278.717457714414;5996.13056106862;6103.6032657877095;6249.875002500015;6268.1851359323;6276.968615156895;4677.064587082597;4720.480747117815;4738.455077666113;4739.810407583727;4753.47711751707;4219.156168766259;4221.957780422218;4232.132412855357;4249.447571815645;4265.50946641134;5866.823995280149;5910.202122713465;5933.6736479493175;5974.253218347707;5987.221661184019;6165.691715414211;6293.433590976834;6312.368763123651;6318.684065796691;6328.525360597973;6033.034714445667;6045.78839740607;6046.455818976313;6048.153258543807;6049.243844519435;5243.8164664236565;5315.893682126336;5406.053940560465;5411.729413529308;5437.45625437461;6434.9678251609375;6548;6552.6068435894;6553;6571.737130514726;6305.085762564494;6306.054091886162;6308.526860485574;6310.1796766420075;6316.62100273985;6212.658303793335;6422.293547709842;6430.099786030053;6492.805215843532;6510.609363438209;6180.505559555135;6236.875262494634;6238.625682459067;6244.843878903063;6252.124702541557;6282.905756413566;6351.9047214290895;6358.872822543431;6366.490680745622;6382.872342553216;6016.578839481194;6057.454829065406;6064.575479716377;6172.783952561639;6175.752969881154;6188.938110619017;6194.690265486617;6203.2556093269095;6203.4416902479;6211.161493198541;6094.299155596986;6097.054956481752;6098.481629061579;6130.754769809158;6147.170132032297;5969.820905372846;6095.1466794647895;6124.693765311806;6217.533684973736;6225.128482012431;6057.091436284592;6057.757689692363;6066.908996364969;6068.939310606837;6087.482563982111 17:54:32 INFO - PROCESS | 4010 | |1;ext.html;586.4604563801303;649.8797722421349;650.4308729861372;666.9433098186653;706.9116360454943;44799.104017919664;46137.538624613786;46226.30660540095;46366.76816615921;46392.30411543825;45641.77179114108;45849;46216.537834621646;46257.30614040784;46318.53681463184;9311.95344023279;9402.200812930909;9412.058794120567;9414.811703765921;9436.103570160823;9173.495457749821;9202.953985230064;9254.167124958753;9303.255739540855;9325.393849399767;9319.114684105;9367.110124538192;9416.764580885465;9420.246380289595;9424.481653509054;9211.723648290563;9263.907360926372;9301.209397201246;9336.11306925841;9340.112689294507;9250.306227032932;9292.860607090899;9319.347645664806;9330.906690933072;9345;44180.337294940604;44270.77864610656;44405.33391999122;44546.33180502263;44761.55238447639;3868.941965870514;4051.534073581546;4228.640565551932;4544.5228251033495;4807.086653535817;34606;35134.29731405383;35188.47217291743;36247;36650;4673.579377856009;4738.265568836836;4780.402449693788;4793.113274044313;4854.490278520775;382378;384268;384484;386194.0690296559;387521;38315.808420958274;38926.2214755709;63815.36184638187;64315.67842160759;64441.67779161074;41094;41145.794271028455;41188.794056029525;41331.173376532905;41387.586124138375;17657.823421765876;17665.116744163;17743.556411089827;17853.910730446263;17866.91066544659;14896.180710060835;14932.178730169944;15001.549953501413;15012.549623511311;15024.399024038916;9204;9264.305177111744;9313;9354.438733676001;9404;3537.2218112015316;3540.451230059345;3544.379733546619;3615.6565126312958;3639.5996440391536;1088.586337191862;1165.3241120150292;1168.182272409317;1197.1560050164612;1212.030375699437;34216.65783342184;34277;34458.31083378319;35126.64873351234;35280;1147.2944139354238;1167.5971789732528;1209.7338585511172;1254.5295514182183;1290.2777571002637;17718.37985670521;17752.644947100987;17777.28890844352;17815.10924453772;17909.910450447664;593380;595019;595043;597039;599106;63513.36486635167;64010;64394.678026610505;64495;64576.35423645703;1494.8280947691155;1498.6777842763859;1515.0758037597057;1528.9464868729542;1537.7001484710597;32301.51547726833;32582;32622;32788;33468.163295917795;56563.434365657464;57774.13338799837;57830.13254801097;58008;58170.4182958165;541478;542182;543634;544927;545579;30538.389232214788;30631;32454;33149.83425082859;33394.165145870575;53236.20145697895;53439.19841202463;53807;54567.45432545624;54737.17894231669;43536.25854965766;44745;44956;46255;46794.76602616965;45710;45825.77087114543;46112.7694361526;46289.22264664131;46312.53687463217;38825.6117438822;43935;44429;44631.55368446274;45060;38311.80844095873;39360.01599960024;40034.39948400835;40605.39091913683;40787;29829.701702982693;30526.542101868934;30756.23109422193;31138;31494 17:54:32 INFO - PROCESS | 4010 | |2;jquery.html;397.5944536572696;408.85076946914387;412.12629226040787;418.49153278766295;424.17074619119626;18828;20477.283295084675;20669.173233070658;21102.472438189052;21446.24938127166;19902.60194796107;19968.600627987467;20095.59808803823;20618.896905515452;20635.27776527818;5861.238039054928;6019.729112189962;6028.4574388305045;6036.849078773022;6074.908876366836;5607.635503692247;5838.5329173666005;5935.85160370992;6001.819945401623;6011.729472173741;5873.911891321633;5932.199153114318;5946.197263369455;5960.582759206857;6039.969800150993;6448.12950251717;6488.837779055514;6509.1863517060365;6684.331566843325;6839.658017099126;5841.0362290222065;5854.385289544579;5864.325602555718;5887.35239123696;5906.291245050578;14116.505922292774;14265.928670356685;15391.461298854487;23859.761402386102;23954.64068038981;2621.187431896099;2736.6031925370708;2788.9442211155665;3024.9848750756328;3036.30165062037;9953.502324883799;10349.068583827491;10434.426106564137;14156.787648185285;15053.924730376388;1922.798106198843;2004.128204231164;2021.86857854239;2031.2890488329115;2070.3788863341088;87797;88179.55910220472;89752;91084;91452.54273728655;11372.374519401346;11519.30884146954;11616.070714342832;11635.243709158878;11769.469968903988;16316.918415407847;16327;16398.26207820651;16429.424970125987;16437.26032328548;8719;8865;8879.200871921557;8987.955060224787;9112.362134650512;8407.285380742584;8511.063782983867;8637.136286371313;8820.25027872638;8837.248833849066;4805.423349198119;4846.814479415298;4896.290037944478;4937.802487900443;4940.629452790983;1943.5529828139606;1974.328728232408;2025.18992403037;2057.825084867773;2093.235968871351;962.3119469579284;1002.6340385759146;1017.3946501831399;1042.3433237060603;1122.8147355686383;20249.29127480531;20574.382768516967;20652.07065682048;20711.689324660143;21013.15947362119;1070.8393740938766;1080.1304949515716;1084.3168803653648;1107.9446027698743;1144.7710457908452;10932.945335273433;11342.149338799458;11354.716132096764;11509.13681473876;11522.251053681484;496873;506756;521408;526789;533070;101228;101659.49170254101;102012;103949.48025259825;105153;1027.8920713325142;1039.3088596083671;1045.7960697663882;1051.7212938571286;1060.7454210989306;17700.734488982416;17962.640747185244;18461.53846153857;18473.353432629792;18588.907055464635;44128.33807492955;44619.55380446154;44910.10179796451;46127.9242434098;46689.29966050444;55755.72122139364;62262.37737622566;62605.373946259955;63418.36581634309;65011;7555.622218888923;7698.422618303762;7759.922400776146;8371.204735550356;8831.735047948572;9224.492652904155;12928.159669621444;12969.54606588765;13087.803682944574;13386.598402047954;10705.304155229886;11005.229633925868;11008;11089.05743011853;11604.709882252673;11003;11039.558417663204;11243.66269011931;11455.770884582094;11599.76800464003;11728.712900984227;11849.52601895949;11868.643940681794;11979.940100299442;12063.517459301529;7721.575313357819;7902.170272121574;7923.84152316962;7947.761567152995;7994.960025199837;10421.478926053818;11361.602343918254;11472.598459053894;11640.708982275512;11738.119641027128 17:54:32 INFO - PROCESS | 4010 | |3;mootools.html;1549.7287974604444;1590.896591721538;1777.315733442625;1890.9694216651924;1898.1173754204292;8956.059613740545;9188.586513606888;9379.812403751937;9984.700458986234;9992.400455972647;9420.105090016456;9790.608375664982;9813.607455701764;9873.753156171098;9876.111149996499;2424.9757502424973;2476.938076548083;2477.752224777517;2477.8513289202615;2478.4423504711476;2443.1815341860497;2504.9373765655914;2520.1557478244717;2523.1547431610343;2529.1527338341584;2496.7378425265356;2504.336350867022;2505.248425472351;2516.9119080832174;2528.4943011397704;2408.5784987627185;2412.19191570824;2420.745821688715;2438.280707191365;2438.8536687798787;2398.9760102398927;2409.5662780699467;2411.3609893378093;2429.9392515187087;2446.7430919753347;9885.456299903502;10039.146672532843;10050.798984020352;10064.094231519199;10068.345557538736;5503.972480137613;5665.093585026417;5712.057510510761;5722.7424765885635;5728.856778580527;3443.724502039831;3586.3903136466865;3587.677109060171;3588.8385022673783;3673.2469843682247;1229.6126720083146;1269.4858582274194;1280.289439361154;1286.2346903592347;1311.2329287366902;13829.377678004414;13876.306184690726;13884.4446222151;13966.650833729238;13982.860171398359;4811.206150985118;4842.782074806642;4860.3195552622665;4870.853874383774;4909.533594308535;11640.708982275512;11646.883531164749;11741.823872641917;11749.823752643717;11796.823047654292;5564.916526252109;5621.915671264935;5668.121441176624;5674.347450043298;5684.317881854204;4596.2416201326405;4995.925061124086;5108.693478391234;5197.064528384927;5242.082635538765;4287.121140166259;4357.629601483846;4432.423784907941;4463.843765468258;4465.419495465634;1338.4646141543267;1350.0424384642308;1366.8974826888023;1370.1094288712218;1376.4425407709894;952.8904176019707;1045.7281106912258;1055.5408397347178;1059.2214722179192;1061.6708820265742;6417.614943103429;6540.901886471706;6549.672516374162;6613.14029176204;6694.933050669529;964.4791812421214;1068.6793961811425;1078.1321036565482;1093.6609651008055;1104.745908441063;4392.165488557164;4527.547245275512;4546.363509108727;4547.522510136454;4574.81700731967;11505.827412588818;12164.148509604243;12330.75338493243;12523.874761252453;12553.05852061099;11972.401379930969;12320.691982700326;12321.630351089481;12334;12355.62933112008;8960.283177345797;9129.224015958718;9166.81666366669;9209.033051529626;9311.580978855833;6326.4622507087415;6558.213014438298;6633;6678.265390807104;6729.461643068641;11110.055645270242;11192.88807111951;11260;11361.37512436824;11409.60066397672;11297.548098075986;11389.886101138882;11463.770724585629;11641.6507504775;11679.941600291944;7948.761537153895;8432.789180270296;8582;8662.740117796477;8845.778855528662;9545.331826772059;9636;9643.132118109404;9663.951680241555;9725.610975560898;8759.386842921189;8790.604422800861;8792.824143517222;8933.553322333988;8945.59744811472;8538.957305213435;8568.914310856811;8610.82778344417;8695;8725.563721814011;7857.135715071452;7973.481723687942;8026.398020148629;8027.237412445808;8062.919370806217;5611.579131565068;5720.3707592165665;5744.655320680772;5778.16216648592;5841.4450627190345;5628.409017053151;5684.459976302244;5721.056025755704;5738.225339579103;5833.854153646193 17:54:32 INFO - PROCESS | 4010 | |4;prototype.html;343.5717721432007;344.1877169879085;344.4127762165508;348.13314846033353;352.6279774837547;5817.389174136718;5876.911846322303;5916.26046744157;5936.079907614316;5953.434423729739;5797.449242321973;5816.447437493442;5833.212516310296;5878.323992740836;5883.735231914563;4109.363048727452;4438.667099967515;4469.955300447003;4472.195004899117;4513;4500.347449619803;4500.482444518873;4501.122281155176;4524.619990902774;4545.499995000548;4474.418325617665;4494.595486406222;4514.210013247669;4517.977410112945;4523.231050721369;4248.851290204843;4461.39771130898;4490.461144662661;4506.369108324837;4509.706869053533;3927.9198220489593;3932.488776459071;3932.705047121449;3934;3936.547297060846;5694.430556944314;5696.857578560528;5700.743466544015;5703.058995265817;5722;4900.264960255954;5062.417821950486;5126.5898728101665;5151.73782423305;5156.948430515722;6089.969550152266;6094.481969032638;6123.755049798003;6142.170806941051;6173.84565385869;4085.55058943516;4290.914181716379;4298.591633794785;4333.8699839004885;4339.804708788112;6230.501559875244;6270.78052268173;6297.2128483939505;6336.398042185985;6336.52476064297;4439.489458712224;4444.8444304449185;4451.888702782457;4468.843590474317;4471.5081341052455;4357.847475338348;4475.865724028285;4508.0533088051225;4522.954770452254;4525.366448697185;5085.389753229636;5126.7180305083575;5133.845984620468;5148.17629179337;5162.406323272871;6097.420745029215;6118.78584249558;6200.286966998763;6228.03465462854;6247.2815626202655;1485.1608841004797;1522.4595268679682;1531.3950989359141;1549.132485807951;1551.7206902757612;956.3305686019814;980.1766516126488;1033.984490232632;1053.1206442620344;1054.8997845204694;5881.617694849821;5881.8826022208295;5889.970550147222;5905.881882362329;5947.345791962881;6213.782517611862;6220.471259942865;6283.2460104787715;6283.6858157091965;6284.560080794392;5772.682502462405;5877.500412464989;5916.26046744157;5934.317553481319;5937.042569454554;3309.834508274577;3315.154635567963;3340.346528468424;3344.1806757344607;3364.4616861302566;6180.412860778219;6414.390632889868;6486.54594178403;6528.869422611521;6623.4038936495945;6489.156409666713;6504.24385415935;6562.8359291018105;6590.538662293593;6627.536072474881;6364.681765911779;6542.499762627067;6644.4020038196795;6658.404461590783;6662.533622646465;6326;6327.588706734047;6354.555181137276;6354.6822658867795;6366.236051673829;6164.722587483484;6300.558960872695;6302.180716506825;6343.524235682435;6357.427831495188;6526;6538.967305163444;6549.639769812706;6590.901136483052;6597.670116494252;4423.756693381766;4473.261911784519;4475.731456112644;4479.440069991251;4496.437945256843;6191.925704888913;6305.779297724557;6365.2361716594305;6446.194225721785;6512.34876512345;6141.109539116893;6182.567220294536;6192.81421557354;6248.375162483715;6249.78125765596;6058.697065146813;6207.317195108625;6208.130861679459;6214.9067763984485;6251.937480625317;5957.54040260139;6066.4540191382985;6105.358937311518;6117.938820611737;6118.694065296629;6190.2571691397325;6209.441150296495;6280.937190628035;6283.183186185766;6323.272823625342;5897.584579700927;6062;6131.908021379593;6145.477634401126;6158.846028849314 17:54:32 INFO - PROCESS | 4010 | |5;yui.html;819.1194465949106;838.660342561263;847.5592691800264;920.6271460058679;947.1097168661457;15094;15542.22288885557;15626.218689065558;15665.295061722236;15683.294251758669;15911.44309949152;16698;16901.83098169018;16906.323747050134;16976.83023169768;861.5046348349692;877.0615441477621;879.7932485865816;883.3021912688968;885.4908427654093;893.6738090596917;902.7066203483861;905.3707673167119;907.5825120444571;908.582052255963;956.5886668732443;958.314804914486;959.0888655777039;959.4243453927622;959.6593209410663;948.2035090523993;948.5826236455972;949.6106596295521;950.2920324358397;950.6007476859701;703.7396163419568;703.8310805406717;704.5279662626053;704.6582407532343;706.4172058052076;17586.384476543386;17890.91054544732;17916.372926947624;18020.90989545057;18053.187606557738;13933.79099313501;14679.77980330296;14801;15909.806764492594;16355.182240887909;14583.343749531297;14691.77962330566;14839.851601483955;14914.403423863032;15128.470503532324;4762.809487620491;4798.47216806151;4939.835970706194;4947.455779864212;4971.726555039471;89455;90373.54813225892;90594;94519.52740236255;96930;12560.937195313965;12566.937165314115;12578.433970471351;12720.300383478812;12721;22521.436964075703;22588;22595.322140335815;22676.546469070858;22688.88655556712;9316.627334906529;9382.67160649374;9432;9437.575309111107;9756.707298781048;5288.550473209743;5296.761645725952;5304.92042619361;5313.707746074003;5413.566914646819;3862.841147655748;3953.584873588289;3970.781607011642;3975.1453437511072;3986.621270979252;681.2472218198918;681.9965900170566;691.0532570378513;693.760652574871;695.6382681005949;676.6650507998572;695.169272719106;745.9780101261198;755.6712829919003;758.3402439877342;9580.712578622653;10141.695749127539;10603.734906627396;10715.678529644123;10835.891641083646;684.9794506164823;697.1181455458849;708.1785129250045;739.4084732214208;742.5210739073267;4790.377250957354;5137.33214682089;5148.639595228373;5188.273641690166;5214.8957020860125;107205.46397267963;130016.08974390966;131646;132831;134546;110753;111668;112601;113451.43274283576;118289;82149.58925205335;82892.17107828845;83295.16704832995;90952.99999999868;106049;10312.535935882754;10698.465076746288;10921.126309895348;11002.229843910849;11135;55428.44571554233;55933.72033139808;56001.71999139978;56110.158347624005;56527.15209271782;72008;80276;82419.5879020601;83853.58073209594;84614.15385846309;13503.59489215325;13693.863061369259;13835.10071845367;13893.096948698303;14427.278636067944;15563.610909726895;15687.843121569094;16209.270582824038;16707.164641768108;16707.582310442336;15866.7619985698;15904.602384940468;16622.418215362406;17385.304587816347;17584;14074.718505630035;15207.391704331703;15424.922875385551;15497.14765687898;16120.596985075466;14570.708585828012;15431.922840385727;15844.52466426009;16011.279492422636;16208.403695241692;11601;11751.529938802352;12221.266723996589;12527.812082818582;12531.74936501283;12492.875071249171;12672.936635316764;12793.872061279268;13273.269970151734;13657.590272291847 17:54:32 INFO - PROCESS | 4010 | __end_tp_report 17:54:32 INFO - PROCESS | 4010 | __start_cc_report 17:54:32 INFO - PROCESS | 4010 | _x_x_mozilla_cycle_collect,317 17:54:32 INFO - PROCESS | 4010 | __end_cc_report 17:54:32 INFO - PROCESS | 4010 | __startTimestamp1471049672963__endTimestamp 17:54:32 INFO - PROCESS | 4010 | 17:54:32 INFO - PROCESS | 4010 | ------- Summary: start ------- 17:54:32 INFO - PROCESS | 4010 | Number of tests: 6 17:54:32 INFO - PROCESS | 4010 | 17:54:32 INFO - PROCESS | 4010 | [#0] dojo.html Cycles:165 Average:5816.33 Median:6057.76 stddev:669.99 (11.1%) stddev-sans-first:644.03 17:54:32 INFO - PROCESS | 4010 | Values: 3372.7 3397.6 3408.0 3413.2 3426.9 5835.4 5839.1 5931.6 5934.8 5938.1 5869.7 5926.1 5930.2 5933.7 5940.0 5304.9 5337.1 5394.5 5403.7 5436.0 5186.9 5200.3 5206.2 5227.7 5236.1 5331.2 5339.3 5343.8 5352.4 5387.9 5358.1 5367.7 5388.8 5394.6 5411.1 5091.1 5108.9 5200.6 5282.2 5367.9 5655.5 5707.6 5725.2 5740.9 5758.8 6123.1 6147.0 6165.3 6173.6 6196.5 5998.0 6153.6 6224.5 6224.6 6228.2 5779.4 5887.9 5891.8 5908.1 5922.6 6412.5 6443.3 6455.2 6456.7 6460.1 5957.9 6072.8 6107.4 6175.0 6183.7 6169.7 6249.7 6279.5 6287.7 6295.5 6243.8 6250.2 6253.4 6254.8 6278.7 5996.1 6103.6 6249.9 6268.2 6277.0 4677.1 4720.5 4738.5 4739.8 4753.5 4219.2 4222.0 4232.1 4249.4 4265.5 5866.8 5910.2 5933.7 5974.3 5987.2 6165.7 6293.4 6312.4 6318.7 6328.5 6033.0 6045.8 6046.5 6048.2 6049.2 5243.8 5315.9 5406.1 5411.7 5437.5 6435.0 6548.0 6552.6 6553.0 6571.7 6305.1 6306.1 6308.5 6310.2 6316.6 6212.7 6422.3 6430.1 6492.8 6510.6 6180.5 6236.9 6238.6 6244.8 6252.1 6282.9 6351.9 6358.9 6366.5 6382.9 6016.6 6057.5 6064.6 6172.8 6175.8 6188.9 6194.7 6203.3 6203.4 6211.2 6094.3 6097.1 6098.5 6130.8 6147.2 5969.8 6095.1 6124.7 6217.5 6225.1 6057.1 6057.8 6066.9 6068.9 6087.5 17:54:32 INFO - PROCESS | 4010 | 17:54:32 INFO - PROCESS | 4010 | [#1] ext.html Cycles:180 Average:66551.99 Median:44780.33 stddev:137339.99 (306.7%) stddev-sans-first:137635.96 17:54:32 INFO - PROCESS | 4010 | Values: 586.5 649.9 650.4 666.9 706.9 44799.1 46137.5 46226.3 46366.8 46392.3 45641.8 45849.0 46216.5 46257.3 46318.5 9312.0 9402.2 9412.1 9414.8 9436.1 9173.5 9203.0 9254.2 9303.3 9325.4 9319.1 9367.1 9416.8 9420.2 9424.5 9211.7 9263.9 9301.2 9336.1 9340.1 9250.3 9292.9 9319.3 9330.9 9345.0 44180.3 44270.8 44405.3 44546.3 44761.6 3868.9 4051.5 4228.6 4544.5 4807.1 34606.0 35134.3 35188.5 36247.0 36650.0 4673.6 4738.3 4780.4 4793.1 4854.5 382378.0 384268.0 384484.0 386194.1 387521.0 38315.8 38926.2 63815.4 64315.7 64441.7 41094.0 41145.8 41188.8 41331.2 41387.6 17657.8 17665.1 17743.6 17853.9 17866.9 14896.2 14932.2 15001.5 15012.5 15024.4 9204.0 9264.3 9313.0 9354.4 9404.0 3537.2 3540.5 3544.4 3615.7 3639.6 1088.6 1165.3 1168.2 1197.2 1212.0 34216.7 34277.0 34458.3 35126.6 35280.0 1147.3 1167.6 1209.7 1254.5 1290.3 17718.4 17752.6 17777.3 17815.1 17909.9 593380.0 595019.0 595043.0 597039.0 599106.0 63513.4 64010.0 64394.7 64495.0 64576.4 1494.8 1498.7 1515.1 1528.9 1537.7 32301.5 32582.0 32622.0 32788.0 33468.2 56563.4 57774.1 57830.1 58008.0 58170.4 541478.0 542182.0 543634.0 544927.0 545579.0 30538.4 30631.0 32454.0 33149.8 33394.2 53236.2 53439.2 53807.0 54567.5 54737.2 43536.3 44745.0 44956.0 46255.0 46794.8 45710.0 45825.8 46112.8 46289.2 46312.5 38825.6 43935.0 44429.0 44631.6 45060.0 38311.8 39360.0 40034.4 40605.4 40787.0 29829.7 30526.5 30756.2 31138.0 31494.0 17:54:32 INFO - PROCESS | 4010 | 17:54:32 INFO - PROCESS | 4010 | [#2] jquery.html Cycles:180 Average:30633.31 Median:11402.46 stddev:85542.03 (750.2%) stddev-sans-first:85751.87 17:54:32 INFO - PROCESS | 4010 | Values: 397.6 408.9 412.1 418.5 424.2 18828.0 20477.3 20669.2 21102.5 21446.2 19902.6 19968.6 20095.6 20618.9 20635.3 5861.2 6019.7 6028.5 6036.8 6074.9 5607.6 5838.5 5935.9 6001.8 6011.7 5873.9 5932.2 5946.2 5960.6 6040.0 6448.1 6488.8 6509.2 6684.3 6839.7 5841.0 5854.4 5864.3 5887.4 5906.3 14116.5 14265.9 15391.5 23859.8 23954.6 2621.2 2736.6 2788.9 3025.0 3036.3 9953.5 10349.1 10434.4 14156.8 15053.9 1922.8 2004.1 2021.9 2031.3 2070.4 87797.0 88179.6 89752.0 91084.0 91452.5 11372.4 11519.3 11616.1 11635.2 11769.5 16316.9 16327.0 16398.3 16429.4 16437.3 8719.0 8865.0 8879.2 8988.0 9112.4 8407.3 8511.1 8637.1 8820.3 8837.2 4805.4 4846.8 4896.3 4937.8 4940.6 1943.6 1974.3 2025.2 2057.8 2093.2 962.3 1002.6 1017.4 1042.3 1122.8 20249.3 20574.4 20652.1 20711.7 21013.2 1070.8 1080.1 1084.3 1107.9 1144.8 10932.9 11342.1 11354.7 11509.1 11522.3 496873.0 506756.0 521408.0 526789.0 533070.0 101228.0 101659.5 102012.0 103949.5 105153.0 1027.9 1039.3 1045.8 1051.7 1060.7 17700.7 17962.6 18461.5 18473.4 18588.9 44128.3 44619.6 44910.1 46127.9 46689.3 55755.7 62262.4 62605.4 63418.4 65011.0 7555.6 7698.4 7759.9 8371.2 8831.7 9224.5 12928.2 12969.5 13087.8 13386.6 10705.3 11005.2 11008.0 11089.1 11604.7 11003.0 11039.6 11243.7 11455.8 11599.8 11728.7 11849.5 11868.6 11979.9 12063.5 7721.6 7902.2 7923.8 7947.8 7995.0 10421.5 11361.6 11472.6 11640.7 11738.1 17:54:32 INFO - PROCESS | 4010 | 17:54:32 INFO - PROCESS | 4010 | [#3] mootools.html Cycles:180 Average:6444.18 Median:4448.13 stddev:3748.00 (84.3%) stddev-sans-first:3740.47 17:54:32 INFO - PROCESS | 4010 | Values: 1549.7 1590.9 1777.3 1891.0 1898.1 8956.1 9188.6 9379.8 9984.7 9992.4 9420.1 9790.6 9813.6 9873.8 9876.1 2425.0 2476.9 2477.8 2477.9 2478.4 2443.2 2504.9 2520.2 2523.2 2529.2 2496.7 2504.3 2505.2 2516.9 2528.5 2408.6 2412.2 2420.7 2438.3 2438.9 2399.0 2409.6 2411.4 2429.9 2446.7 9885.5 10039.1 10050.8 10064.1 10068.3 5504.0 5665.1 5712.1 5722.7 5728.9 3443.7 3586.4 3587.7 3588.8 3673.2 1229.6 1269.5 1280.3 1286.2 1311.2 13829.4 13876.3 13884.4 13966.7 13982.9 4811.2 4842.8 4860.3 4870.9 4909.5 11640.7 11646.9 11741.8 11749.8 11796.8 5564.9 5621.9 5668.1 5674.3 5684.3 4596.2 4995.9 5108.7 5197.1 5242.1 4287.1 4357.6 4432.4 4463.8 4465.4 1338.5 1350.0 1366.9 1370.1 1376.4 952.9 1045.7 1055.5 1059.2 1061.7 6417.6 6540.9 6549.7 6613.1 6694.9 964.5 1068.7 1078.1 1093.7 1104.7 4392.2 4527.5 4546.4 4547.5 4574.8 11505.8 12164.1 12330.8 12523.9 12553.1 11972.4 12320.7 12321.6 12334.0 12355.6 8960.3 9129.2 9166.8 9209.0 9311.6 6326.5 6558.2 6633.0 6678.3 6729.5 11110.1 11192.9 11260.0 11361.4 11409.6 11297.5 11389.9 11463.8 11641.7 11679.9 7948.8 8432.8 8582.0 8662.7 8845.8 9545.3 9636.0 9643.1 9664.0 9725.6 8759.4 8790.6 8792.8 8933.6 8945.6 8539.0 8568.9 8610.8 8695.0 8725.6 7857.1 7973.5 8026.4 8027.2 8062.9 5611.6 5720.4 5744.7 5778.2 5841.4 5628.4 5684.5 5721.1 5738.2 5833.9 17:54:32 INFO - PROCESS | 4010 | 17:54:32 INFO - PROCESS | 4010 | [#4] prototype.html Cycles:180 Average:5164.86 Median:5901.73 stddev:1552.40 (26.3%) stddev-sans-first:1513.99 17:54:32 INFO - PROCESS | 4010 | Values: 343.6 344.2 344.4 348.1 352.6 5817.4 5876.9 5916.3 5936.1 5953.4 5797.4 5816.4 5833.2 5878.3 5883.7 4109.4 4438.7 4470.0 4472.2 4513.0 4500.3 4500.5 4501.1 4524.6 4545.5 4474.4 4494.6 4514.2 4518.0 4523.2 4248.9 4461.4 4490.5 4506.4 4509.7 3927.9 3932.5 3932.7 3934.0 3936.5 5694.4 5696.9 5700.7 5703.1 5722.0 4900.3 5062.4 5126.6 5151.7 5156.9 6090.0 6094.5 6123.8 6142.2 6173.8 4085.6 4290.9 4298.6 4333.9 4339.8 6230.5 6270.8 6297.2 6336.4 6336.5 4439.5 4444.8 4451.9 4468.8 4471.5 4357.8 4475.9 4508.1 4523.0 4525.4 5085.4 5126.7 5133.8 5148.2 5162.4 6097.4 6118.8 6200.3 6228.0 6247.3 1485.2 1522.5 1531.4 1549.1 1551.7 956.3 980.2 1034.0 1053.1 1054.9 5881.6 5881.9 5890.0 5905.9 5947.3 6213.8 6220.5 6283.2 6283.7 6284.6 5772.7 5877.5 5916.3 5934.3 5937.0 3309.8 3315.2 3340.3 3344.2 3364.5 6180.4 6414.4 6486.5 6528.9 6623.4 6489.2 6504.2 6562.8 6590.5 6627.5 6364.7 6542.5 6644.4 6658.4 6662.5 6326.0 6327.6 6354.6 6354.7 6366.2 6164.7 6300.6 6302.2 6343.5 6357.4 6526.0 6539.0 6549.6 6590.9 6597.7 4423.8 4473.3 4475.7 4479.4 4496.4 6191.9 6305.8 6365.2 6446.2 6512.3 6141.1 6182.6 6192.8 6248.4 6249.8 6058.7 6207.3 6208.1 6214.9 6251.9 5957.5 6066.5 6105.4 6117.9 6118.7 6190.3 6209.4 6280.9 6283.2 6323.3 5897.6 6062.0 6131.9 6145.5 6158.8 17:54:32 INFO - PROCESS | 4010 | 17:54:32 INFO - PROCESS | 4010 | [#5] yui.html Cycles:180 Average:23166.41 Median:3908.21 stddev:33403.94 (854.7%) stddev-sans-first:33455.50 17:54:32 INFO - PROCESS | 4010 | Values: 819.1 838.7 847.6 920.6 947.1 15094.0 15542.2 15626.2 15665.3 15683.3 15911.4 16698.0 16901.8 16906.3 16976.8 861.5 877.1 879.8 883.3 885.5 893.7 902.7 905.4 907.6 908.6 956.6 958.3 959.1 959.4 959.7 948.2 948.6 949.6 950.3 950.6 703.7 703.8 704.5 704.7 706.4 17586.4 17890.9 17916.4 18020.9 18053.2 13933.8 14679.8 14801.0 15909.8 16355.2 14583.3 14691.8 14839.9 14914.4 15128.5 4762.8 4798.5 4939.8 4947.5 4971.7 89455.0 90373.5 90594.0 94519.5 96930.0 12560.9 12566.9 12578.4 12720.3 12721.0 22521.4 22588.0 22595.3 22676.5 22688.9 9316.6 9382.7 9432.0 9437.6 9756.7 5288.6 5296.8 5304.9 5313.7 5413.6 3862.8 3953.6 3970.8 3975.1 3986.6 681.2 682.0 691.1 693.8 695.6 676.7 695.2 746.0 755.7 758.3 9580.7 10141.7 10603.7 10715.7 10835.9 685.0 697.1 708.2 739.4 742.5 4790.4 5137.3 5148.6 5188.3 5214.9 107205.5 130016.1 131646.0 132831.0 134546.0 110753.0 111668.0 112601.0 113451.4 118289.0 82149.6 82892.2 83295.2 90953.0 106049.0 10312.5 10698.5 10921.1 11002.2 11135.0 55428.4 55933.7 56001.7 56110.2 56527.2 72008.0 80276.0 82419.6 83853.6 84614.2 13503.6 13693.9 13835.1 13893.1 14427.3 15563.6 15687.8 16209.3 16707.2 16707.6 15866.8 15904.6 16622.4 17385.3 17584.0 14074.7 15207.4 15424.9 15497.1 16120.6 14570.7 15431.9 15844.5 16011.3 16208.4 11601.0 11751.5 12221.3 12527.8 12531.7 12492.9 12672.9 12793.9 13273.3 13657.6 17:54:32 INFO - PROCESS | 4010 | -------- Summary: end -------- 17:54:32 INFO - PROCESS | 4010 | 17:54:33 INFO - TEST-INFO | 4010: exit 0 17:54:33 INFO - TEST-OK | dromaeo_css | took 1111354ms 17:54:33 INFO - TEST-START | kraken 17:54:33 INFO - operating with platform_type : linux_ 17:54:33 INFO - Initialising browser for kraken test... 17:54:33 INFO - TEST-INFO | started process 4273 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJHf2Qe/profile http://localhost:50362/getInfo.html) 17:54:38 INFO - PROCESS | 4273 | __metrics Screen width/height:1600/1200 17:54:38 INFO - PROCESS | 4273 | colorDepth:24 17:54:38 INFO - PROCESS | 4273 | Browser inner width/height: 1024/697 17:54:38 INFO - PROCESS | 4273 | __metrics 17:54:38 ERROR - PROCESS | 4273 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 17:54:39 INFO - TEST-INFO | 4273: exit 0 17:54:39 INFO - Browser initialized. 17:54:39 INFO - Running cycle 1/1 for kraken test... 17:54:39 INFO - TEST-INFO | started process 4395 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJHf2Qe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:54:51 INFO - PROCESS | 4395 | RSS: Main: 152858624 17:54:51 INFO - PROCESS | 4395 | 17:54:54 INFO - PROCESS | 4395 | Cycle 1(1): loaded http://localhost:50362/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50362/tests/kraken/driver.html?testName=audio-beat-detection) 17:54:54 INFO - PROCESS | 4395 | RSS: Main: 158191616 17:54:54 INFO - PROCESS | 4395 | 17:54:57 INFO - PROCESS | 4395 | Cycle 1(1): loaded http://localhost:50362/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50362/tests/kraken/driver.html?testName=audio-dft) 17:54:58 INFO - PROCESS | 4395 | RSS: Main: 156721152 17:54:58 INFO - PROCESS | 4395 | 17:55:01 INFO - PROCESS | 4395 | Cycle 1(1): loaded http://localhost:50362/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50362/tests/kraken/driver.html?testName=audio-fft) 17:55:01 INFO - PROCESS | 4395 | RSS: Main: 157933568 17:55:01 INFO - PROCESS | 4395 | 17:55:03 INFO - PROCESS | 4395 | Cycle 1(1): loaded http://localhost:50362/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50362/tests/kraken/driver.html?testName=audio-oscillator) 17:55:04 INFO - PROCESS | 4395 | RSS: Main: 157085696 17:55:04 INFO - PROCESS | 4395 | 17:55:06 INFO - PROCESS | 4395 | Cycle 1(1): loaded http://localhost:50362/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50362/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:55:07 INFO - PROCESS | 4395 | RSS: Main: 156848128 17:55:07 INFO - PROCESS | 4395 | 17:55:10 INFO - PROCESS | 4395 | Cycle 1(1): loaded http://localhost:50362/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50362/tests/kraken/driver.html?testName=imaging-darkroom) 17:55:10 INFO - PROCESS | 4395 | RSS: Main: 156913664 17:55:10 INFO - PROCESS | 4395 | 17:55:14 INFO - PROCESS | 4395 | Cycle 1(1): loaded http://localhost:50362/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50362/tests/kraken/driver.html?testName=imaging-desaturate) 17:55:15 INFO - PROCESS | 4395 | RSS: Main: 154779648 17:55:15 INFO - PROCESS | 4395 | 17:55:17 INFO - PROCESS | 4395 | Cycle 1(1): loaded http://localhost:50362/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50362/tests/kraken/driver.html?testName=json-parse-financial) 17:55:18 INFO - PROCESS | 4395 | RSS: Main: 156934144 17:55:18 INFO - PROCESS | 4395 | 17:55:20 INFO - PROCESS | 4395 | Cycle 1(1): loaded http://localhost:50362/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50362/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:55:20 INFO - PROCESS | 4395 | RSS: Main: 157577216 17:55:20 INFO - PROCESS | 4395 | 17:55:22 INFO - PROCESS | 4395 | Cycle 1(1): loaded http://localhost:50362/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50362/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:55:23 INFO - PROCESS | 4395 | RSS: Main: 156893184 17:55:23 INFO - PROCESS | 4395 | 17:55:24 INFO - PROCESS | 4395 | Cycle 1(1): loaded http://localhost:50362/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50362/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:55:25 INFO - PROCESS | 4395 | RSS: Main: 157085696 17:55:25 INFO - PROCESS | 4395 | 17:55:28 INFO - PROCESS | 4395 | Cycle 1(1): loaded http://localhost:50362/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50362/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:55:28 INFO - PROCESS | 4395 | RSS: Main: 157642752 17:55:28 INFO - PROCESS | 4395 | 17:55:31 INFO - PROCESS | 4395 | Cycle 1(1): loaded http://localhost:50362/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50362/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:55:32 INFO - PROCESS | 4395 | RSS: Main: 157573120 17:55:32 INFO - PROCESS | 4395 | 17:55:33 INFO - PROCESS | 4395 | Cycle 1(1): loaded http://localhost:50362/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50362/tests/kraken/driver.html?testName=ai-astar) 17:55:34 INFO - PROCESS | 4395 | RSS: Main: 158474240 17:55:34 INFO - PROCESS | 4395 | 17:55:34 INFO - PROCESS | 4395 | __start_tp_report 17:55:34 INFO - PROCESS | 4395 | _x_x_mozilla_page_load 17:55:34 INFO - PROCESS | 4395 | _x_x_mozilla_page_load_details 17:55:34 INFO - PROCESS | 4395 | |i|pagename|runs| 17:55:34 INFO - PROCESS | 4395 | |0;ai-astar;100;112;104;111;112;111;109;110;109;109 17:55:34 INFO - PROCESS | 4395 | |1;audio-beat-detection;167;124;155;170;117;149;155;121;177;117 17:55:34 INFO - PROCESS | 4395 | |2;audio-dft;163;161;163;162;161;161;161;160;161;162 17:55:34 INFO - PROCESS | 4395 | |3;audio-fft;74;75;74;195;76;75;74;76;164;76 17:55:34 INFO - PROCESS | 4395 | |4;audio-oscillator;83;83;146;83;83;85;141;84;84;132 17:55:34 INFO - PROCESS | 4395 | |5;imaging-gaussian-blur;118;117;117;118;117;118;118;120;118;117 17:55:34 INFO - PROCESS | 4395 | |6;imaging-darkroom;148;147;146;148;148;146;147;150;148;147 17:55:34 INFO - PROCESS | 4395 | |7;imaging-desaturate;95;95;95;95;95;95;95;96;95;95 17:55:34 INFO - PROCESS | 4395 | |8;json-parse-financial;53;51;51;51;54;51;51;53;52;52 17:55:34 INFO - PROCESS | 4395 | |9;json-stringify-tinderbox;59;59;59;59;60;59;59;59;58;59 17:55:34 INFO - PROCESS | 4395 | |10;stanford-crypto-aes;76;72;72;72;75;78;73;81;76;72 17:55:34 INFO - PROCESS | 4395 | |11;stanford-crypto-ccm;134;124;128;117;132;117;119;129;162;128 17:55:34 INFO - PROCESS | 4395 | |12;stanford-crypto-pbkdf2;151;149;161;147;151;149;151;152;150;158 17:55:34 INFO - PROCESS | 4395 | |13;stanford-crypto-sha256-iterative;69;61;65;62;60;60;62;60;60;60 17:55:34 INFO - PROCESS | 4395 | __end_tp_report 17:55:34 INFO - PROCESS | 4395 | __start_cc_report 17:55:34 INFO - PROCESS | 4395 | _x_x_mozilla_cycle_collect,848 17:55:34 INFO - PROCESS | 4395 | __end_cc_report 17:55:34 INFO - PROCESS | 4395 | __startTimestamp1471049734010__endTimestamp 17:55:34 INFO - PROCESS | 4395 | 17:55:34 INFO - PROCESS | 4395 | ------- Summary: start ------- 17:55:34 INFO - PROCESS | 4395 | Number of tests: 14 17:55:34 INFO - PROCESS | 4395 | 17:55:34 INFO - PROCESS | 4395 | [#0] ai-astar Cycles:10 Average:108.70 Median:110.50 stddev:3.83 (3.5%) stddev-sans-first:2.45 17:55:34 INFO - PROCESS | 4395 | Values: 100.0 112.0 104.0 111.0 112.0 111.0 109.0 110.0 109.0 109.0 17:55:34 INFO - PROCESS | 4395 | 17:55:34 INFO - PROCESS | 4395 | [#1] audio-beat-detection Cycles:10 Average:145.20 Median:155.00 stddev:23.41 (15.1%) stddev-sans-first:23.47 17:55:34 INFO - PROCESS | 4395 | Values: 167.0 124.0 155.0 170.0 117.0 149.0 155.0 121.0 177.0 117.0 17:55:34 INFO - PROCESS | 4395 | 17:55:34 INFO - PROCESS | 4395 | [#2] audio-dft Cycles:10 Average:161.50 Median:161.50 stddev:0.97 (0.6%) stddev-sans-first:0.87 17:55:34 INFO - PROCESS | 4395 | Values: 163.0 161.0 163.0 162.0 161.0 161.0 161.0 160.0 161.0 162.0 17:55:34 INFO - PROCESS | 4395 | 17:55:34 INFO - PROCESS | 4395 | [#3] audio-fft Cycles:10 Average:95.90 Median:75.00 stddev:44.67 (59.6%) stddev-sans-first:46.67 17:55:34 INFO - PROCESS | 4395 | Values: 74.0 75.0 74.0 195.0 76.0 75.0 74.0 76.0 164.0 76.0 17:55:34 INFO - PROCESS | 4395 | 17:55:34 INFO - PROCESS | 4395 | [#4] audio-oscillator Cycles:10 Average:100.40 Median:83.00 stddev:27.31 (32.9%) stddev-sans-first:28.23 17:55:34 INFO - PROCESS | 4395 | Values: 83.0 83.0 146.0 83.0 83.0 85.0 141.0 84.0 84.0 132.0 17:55:34 INFO - PROCESS | 4395 | 17:55:34 INFO - PROCESS | 4395 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.92 (0.8%) stddev-sans-first:0.97 17:55:34 INFO - PROCESS | 4395 | Values: 118.0 117.0 117.0 118.0 117.0 118.0 118.0 120.0 118.0 117.0 17:55:34 INFO - PROCESS | 4395 | 17:55:34 INFO - PROCESS | 4395 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:148.00 stddev:1.18 (0.8%) stddev-sans-first:1.24 17:55:34 INFO - PROCESS | 4395 | Values: 148.0 147.0 146.0 148.0 148.0 146.0 147.0 150.0 148.0 147.0 17:55:34 INFO - PROCESS | 4395 | 17:55:34 INFO - PROCESS | 4395 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 17:55:34 INFO - PROCESS | 4395 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 17:55:34 INFO - PROCESS | 4395 | 17:55:34 INFO - PROCESS | 4395 | [#8] json-parse-financial Cycles:10 Average:51.90 Median:52.00 stddev:1.10 (2.1%) stddev-sans-first:1.09 17:55:34 INFO - PROCESS | 4395 | Values: 53.0 51.0 51.0 51.0 54.0 51.0 51.0 53.0 52.0 52.0 17:55:34 INFO - PROCESS | 4395 | 17:55:34 INFO - PROCESS | 4395 | [#9] json-stringify-tinderbox Cycles:10 Average:59.00 Median:59.00 stddev:0.47 (0.8%) stddev-sans-first:0.50 17:55:34 INFO - PROCESS | 4395 | Values: 59.0 59.0 59.0 59.0 60.0 59.0 59.0 59.0 58.0 59.0 17:55:34 INFO - PROCESS | 4395 | 17:55:34 INFO - PROCESS | 4395 | [#10] stanford-crypto-aes Cycles:10 Average:74.70 Median:75.50 stddev:3.09 (4.1%) stddev-sans-first:3.24 17:55:34 INFO - PROCESS | 4395 | Values: 76.0 72.0 72.0 72.0 75.0 78.0 73.0 81.0 76.0 72.0 17:55:34 INFO - PROCESS | 4395 | 17:55:34 INFO - PROCESS | 4395 | [#11] stanford-crypto-ccm Cycles:10 Average:129.00 Median:128.50 stddev:13.07 (10.2%) stddev-sans-first:13.74 17:55:34 INFO - PROCESS | 4395 | Values: 134.0 124.0 128.0 117.0 132.0 117.0 119.0 129.0 162.0 128.0 17:55:34 INFO - PROCESS | 4395 | 17:55:34 INFO - PROCESS | 4395 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.90 Median:151.00 stddev:4.31 (2.9%) stddev-sans-first:4.56 17:55:34 INFO - PROCESS | 4395 | Values: 151.0 149.0 161.0 147.0 151.0 149.0 151.0 152.0 150.0 158.0 17:55:34 INFO - PROCESS | 4395 | 17:55:34 INFO - PROCESS | 4395 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.90 Median:61.50 stddev:2.96 (4.8%) stddev-sans-first:1.69 17:55:34 INFO - PROCESS | 4395 | Values: 69.0 61.0 65.0 62.0 60.0 60.0 62.0 60.0 60.0 60.0 17:55:34 INFO - PROCESS | 4395 | -------- Summary: end -------- 17:55:34 INFO - PROCESS | 4395 | 17:55:34 INFO - TEST-INFO | 4395: exit 0 17:55:34 INFO - TEST-OK | kraken | took 61245ms 17:55:34 INFO - SUITE-END | took 1172s 17:55:35 INFO - Completed test suite (00:19:32) 17:55:35 INFO - javascript benchmark 17:55:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7826.0792107887955, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3372.7301815854735, 3397.5922889253293, 3408.0287118171327, 3413.23202279487, 3426.948595771062, 5835.416458354162, 5839.0949402842525, 5931.614445061068, 5934.821955341341, 5938.1389698493695, 5869.677167755772, 5926.1110833374905, 5930.199423077883, 5933.673647949361, 5940.04959206527, 5304.867378315535, 5337.092694241969, 5394.514493695567, 5403.675779453245, 5435.972820135894, 5186.92219616706, 5200.271961925334, 5206.193040078775, 5227.686338819683, 5236.109861323565, 5331.2269720890445, 5339.252504649352, 5343.786248550054, 5352.437994010612, 5387.865303367408, 5358.115910874721, 5367.651102678314, 5388.78444862205, 5394.6493477924205, 5411.134218525017, 5091.134507133759, 5108.948910510884, 5200.635955483118, 5282.181261904411, 5367.865803354908, 5655.4910058094965, 5707.6290041147195, 5725.227094342294, 5740.942590574083, 5758.79844205455, 6123.050927106306, 6147.047207682772, 6165.290991535986, 6173.567850250484, 6196.504279657616, 5998.010328295826, 6153.569250152491, 6224.533160013018, 6224.595401298946, 6228.190335256433, 5779.393163717791, 5887.882242355129, 5891.764329426818, 5908.113782932594, 5922.58541902067, 6412.5190610704385, 6443.323451037667, 6455.193100862392, 6456.677166141674, 6460.095586617877, 5957.940420595739, 6072.787452439144, 6107.389261073946, 6175.042868355412, 6183.721732522047, 6169.691515424211, 6249.6875156242, 6279.529035322369, 6287.748490060347, 6295.464885484694, 6243.843903902439, 6250.218722659668, 6253.405926436982, 6254.843628909313, 6278.717457714414, 5996.13056106862, 6103.6032657877095, 6249.875002500015, 6268.1851359323, 6276.968615156895, 4677.064587082597, 4720.480747117815, 4738.455077666113, 4739.810407583727, 4753.47711751707, 4219.156168766259, 4221.957780422218, 4232.132412855357, 4249.447571815645, 4265.50946641134, 5866.823995280149, 5910.202122713465, 5933.6736479493175, 5974.253218347707, 5987.221661184019, 6165.691715414211, 6293.433590976834, 6312.368763123651, 6318.684065796691, 6328.525360597973, 6033.034714445667, 6045.78839740607, 6046.455818976313, 6048.153258543807, 6049.243844519435, 5243.8164664236565, 5315.893682126336, 5406.053940560465, 5411.729413529308, 5437.45625437461, 6434.9678251609375, 6548.0, 6552.6068435894, 6553.0, 6571.737130514726, 6305.085762564494, 6306.054091886162, 6308.526860485574, 6310.1796766420075, 6316.62100273985, 6212.658303793335, 6422.293547709842, 6430.099786030053, 6492.805215843532, 6510.609363438209, 6180.505559555135, 6236.875262494634, 6238.625682459067, 6244.843878903063, 6252.124702541557, 6282.905756413566, 6351.9047214290895, 6358.872822543431, 6366.490680745622, 6382.872342553216, 6016.578839481194, 6057.454829065406, 6064.575479716377, 6172.783952561639, 6175.752969881154, 6188.938110619017, 6194.690265486617, 6203.2556093269095, 6203.4416902479, 6211.161493198541, 6094.299155596986, 6097.054956481752, 6098.481629061579, 6130.754769809158, 6147.170132032297, 5969.820905372846, 6095.1466794647895, 6124.693765311806, 6217.533684973736, 6225.128482012431, 6057.091436284592, 6057.757689692363, 6066.908996364969, 6068.939310606837, 6087.482563982111], "value": 5770.54989820943, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [586.4604563801303, 649.8797722421349, 650.4308729861372, 666.9433098186653, 706.9116360454943, 44799.104017919664, 46137.538624613786, 46226.30660540095, 46366.76816615921, 46392.30411543825, 45641.77179114108, 45849.0, 46216.537834621646, 46257.30614040784, 46318.53681463184, 9311.95344023279, 9402.200812930909, 9412.058794120567, 9414.811703765921, 9436.103570160823, 9173.495457749821, 9202.953985230064, 9254.167124958753, 9303.255739540855, 9325.393849399767, 9319.114684105, 9367.110124538192, 9416.764580885465, 9420.246380289595, 9424.481653509054, 9211.723648290563, 9263.907360926372, 9301.209397201246, 9336.11306925841, 9340.112689294507, 9250.306227032932, 9292.860607090899, 9319.347645664806, 9330.906690933072, 9345.0, 44180.337294940604, 44270.77864610656, 44405.33391999122, 44546.33180502263, 44761.55238447639, 3868.941965870514, 4051.534073581546, 4228.640565551932, 4544.5228251033495, 4807.086653535817, 34606.0, 35134.29731405383, 35188.47217291743, 36247.0, 36650.0, 4673.579377856009, 4738.265568836836, 4780.402449693788, 4793.113274044313, 4854.490278520775, 382378.0, 384268.0, 384484.0, 386194.0690296559, 387521.0, 38315.808420958274, 38926.2214755709, 63815.36184638187, 64315.67842160759, 64441.67779161074, 41094.0, 41145.794271028455, 41188.794056029525, 41331.173376532905, 41387.586124138375, 17657.823421765876, 17665.116744163, 17743.556411089827, 17853.910730446263, 17866.91066544659, 14896.180710060835, 14932.178730169944, 15001.549953501413, 15012.549623511311, 15024.399024038916, 9204.0, 9264.305177111744, 9313.0, 9354.438733676001, 9404.0, 3537.2218112015316, 3540.451230059345, 3544.379733546619, 3615.6565126312958, 3639.5996440391536, 1088.586337191862, 1165.3241120150292, 1168.182272409317, 1197.1560050164612, 1212.030375699437, 34216.65783342184, 34277.0, 34458.31083378319, 35126.64873351234, 35280.0, 1147.2944139354238, 1167.5971789732528, 1209.7338585511172, 1254.5295514182183, 1290.2777571002637, 17718.37985670521, 17752.644947100987, 17777.28890844352, 17815.10924453772, 17909.910450447664, 593380.0, 595019.0, 595043.0, 597039.0, 599106.0, 63513.36486635167, 64010.0, 64394.678026610505, 64495.0, 64576.35423645703, 1494.8280947691155, 1498.6777842763859, 1515.0758037597057, 1528.9464868729542, 1537.7001484710597, 32301.51547726833, 32582.0, 32622.0, 32788.0, 33468.163295917795, 56563.434365657464, 57774.13338799837, 57830.13254801097, 58008.0, 58170.4182958165, 541478.0, 542182.0, 543634.0, 544927.0, 545579.0, 30538.389232214788, 30631.0, 32454.0, 33149.83425082859, 33394.165145870575, 53236.20145697895, 53439.19841202463, 53807.0, 54567.45432545624, 54737.17894231669, 43536.25854965766, 44745.0, 44956.0, 46255.0, 46794.76602616965, 45710.0, 45825.77087114543, 46112.7694361526, 46289.22264664131, 46312.53687463217, 38825.6117438822, 43935.0, 44429.0, 44631.55368446274, 45060.0, 38311.80844095873, 39360.01599960024, 40034.39948400835, 40605.39091913683, 40787.0, 29829.701702982693, 30526.542101868934, 30756.23109422193, 31138.0, 31494.0], "value": 20704.597541745356, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [397.5944536572696, 408.85076946914387, 412.12629226040787, 418.49153278766295, 424.17074619119626, 18828.0, 20477.283295084675, 20669.173233070658, 21102.472438189052, 21446.24938127166, 19902.60194796107, 19968.600627987467, 20095.59808803823, 20618.896905515452, 20635.27776527818, 5861.238039054928, 6019.729112189962, 6028.4574388305045, 6036.849078773022, 6074.908876366836, 5607.635503692247, 5838.5329173666005, 5935.85160370992, 6001.819945401623, 6011.729472173741, 5873.911891321633, 5932.199153114318, 5946.197263369455, 5960.582759206857, 6039.969800150993, 6448.12950251717, 6488.837779055514, 6509.1863517060365, 6684.331566843325, 6839.658017099126, 5841.0362290222065, 5854.385289544579, 5864.325602555718, 5887.35239123696, 5906.291245050578, 14116.505922292774, 14265.928670356685, 15391.461298854487, 23859.761402386102, 23954.64068038981, 2621.187431896099, 2736.6031925370708, 2788.9442211155665, 3024.9848750756328, 3036.30165062037, 9953.502324883799, 10349.068583827491, 10434.426106564137, 14156.787648185285, 15053.924730376388, 1922.798106198843, 2004.128204231164, 2021.86857854239, 2031.2890488329115, 2070.3788863341088, 87797.0, 88179.55910220472, 89752.0, 91084.0, 91452.54273728655, 11372.374519401346, 11519.30884146954, 11616.070714342832, 11635.243709158878, 11769.469968903988, 16316.918415407847, 16327.0, 16398.26207820651, 16429.424970125987, 16437.26032328548, 8719.0, 8865.0, 8879.200871921557, 8987.955060224787, 9112.362134650512, 8407.285380742584, 8511.063782983867, 8637.136286371313, 8820.25027872638, 8837.248833849066, 4805.423349198119, 4846.814479415298, 4896.290037944478, 4937.802487900443, 4940.629452790983, 1943.5529828139606, 1974.328728232408, 2025.18992403037, 2057.825084867773, 2093.235968871351, 962.3119469579284, 1002.6340385759146, 1017.3946501831399, 1042.3433237060603, 1122.8147355686383, 20249.29127480531, 20574.382768516967, 20652.07065682048, 20711.689324660143, 21013.15947362119, 1070.8393740938766, 1080.1304949515716, 1084.3168803653648, 1107.9446027698743, 1144.7710457908452, 10932.945335273433, 11342.149338799458, 11354.716132096764, 11509.13681473876, 11522.251053681484, 496873.0, 506756.0, 521408.0, 526789.0, 533070.0, 101228.0, 101659.49170254101, 102012.0, 103949.48025259825, 105153.0, 1027.8920713325142, 1039.3088596083671, 1045.7960697663882, 1051.7212938571286, 1060.7454210989306, 17700.734488982416, 17962.640747185244, 18461.53846153857, 18473.353432629792, 18588.907055464635, 44128.33807492955, 44619.55380446154, 44910.10179796451, 46127.9242434098, 46689.29966050444, 55755.72122139364, 62262.37737622566, 62605.373946259955, 63418.36581634309, 65011.0, 7555.622218888923, 7698.422618303762, 7759.922400776146, 8371.204735550356, 8831.735047948572, 9224.492652904155, 12928.159669621444, 12969.54606588765, 13087.803682944574, 13386.598402047954, 10705.304155229886, 11005.229633925868, 11008.0, 11089.05743011853, 11604.709882252673, 11003.0, 11039.558417663204, 11243.66269011931, 11455.770884582094, 11599.76800464003, 11728.712900984227, 11849.52601895949, 11868.643940681794, 11979.940100299442, 12063.517459301529, 7721.575313357819, 7902.170272121574, 7923.84152316962, 7947.761567152995, 7994.960025199837, 10421.478926053818, 11361.602343918254, 11472.598459053894, 11640.708982275512, 11738.119641027128], "value": 9592.838481394221, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1549.7287974604444, 1590.896591721538, 1777.315733442625, 1890.9694216651924, 1898.1173754204292, 8956.059613740545, 9188.586513606888, 9379.812403751937, 9984.700458986234, 9992.400455972647, 9420.105090016456, 9790.608375664982, 9813.607455701764, 9873.753156171098, 9876.111149996499, 2424.9757502424973, 2476.938076548083, 2477.752224777517, 2477.8513289202615, 2478.4423504711476, 2443.1815341860497, 2504.9373765655914, 2520.1557478244717, 2523.1547431610343, 2529.1527338341584, 2496.7378425265356, 2504.336350867022, 2505.248425472351, 2516.9119080832174, 2528.4943011397704, 2408.5784987627185, 2412.19191570824, 2420.745821688715, 2438.280707191365, 2438.8536687798787, 2398.9760102398927, 2409.5662780699467, 2411.3609893378093, 2429.9392515187087, 2446.7430919753347, 9885.456299903502, 10039.146672532843, 10050.798984020352, 10064.094231519199, 10068.345557538736, 5503.972480137613, 5665.093585026417, 5712.057510510761, 5722.7424765885635, 5728.856778580527, 3443.724502039831, 3586.3903136466865, 3587.677109060171, 3588.8385022673783, 3673.2469843682247, 1229.6126720083146, 1269.4858582274194, 1280.289439361154, 1286.2346903592347, 1311.2329287366902, 13829.377678004414, 13876.306184690726, 13884.4446222151, 13966.650833729238, 13982.860171398359, 4811.206150985118, 4842.782074806642, 4860.3195552622665, 4870.853874383774, 4909.533594308535, 11640.708982275512, 11646.883531164749, 11741.823872641917, 11749.823752643717, 11796.823047654292, 5564.916526252109, 5621.915671264935, 5668.121441176624, 5674.347450043298, 5684.317881854204, 4596.2416201326405, 4995.925061124086, 5108.693478391234, 5197.064528384927, 5242.082635538765, 4287.121140166259, 4357.629601483846, 4432.423784907941, 4463.843765468258, 4465.419495465634, 1338.4646141543267, 1350.0424384642308, 1366.8974826888023, 1370.1094288712218, 1376.4425407709894, 952.8904176019707, 1045.7281106912258, 1055.5408397347178, 1059.2214722179192, 1061.6708820265742, 6417.614943103429, 6540.901886471706, 6549.672516374162, 6613.14029176204, 6694.933050669529, 964.4791812421214, 1068.6793961811425, 1078.1321036565482, 1093.6609651008055, 1104.745908441063, 4392.165488557164, 4527.547245275512, 4546.363509108727, 4547.522510136454, 4574.81700731967, 11505.827412588818, 12164.148509604243, 12330.75338493243, 12523.874761252453, 12553.05852061099, 11972.401379930969, 12320.691982700326, 12321.630351089481, 12334.0, 12355.62933112008, 8960.283177345797, 9129.224015958718, 9166.81666366669, 9209.033051529626, 9311.580978855833, 6326.4622507087415, 6558.213014438298, 6633.0, 6678.265390807104, 6729.461643068641, 11110.055645270242, 11192.88807111951, 11260.0, 11361.37512436824, 11409.60066397672, 11297.548098075986, 11389.886101138882, 11463.770724585629, 11641.6507504775, 11679.941600291944, 7948.761537153895, 8432.789180270296, 8582.0, 8662.740117796477, 8845.778855528662, 9545.331826772059, 9636.0, 9643.132118109404, 9663.951680241555, 9725.610975560898, 8759.386842921189, 8790.604422800861, 8792.824143517222, 8933.553322333988, 8945.59744811472, 8538.957305213435, 8568.914310856811, 8610.82778344417, 8695.0, 8725.563721814011, 7857.135715071452, 7973.481723687942, 8026.398020148629, 8027.237412445808, 8062.919370806217, 5611.579131565068, 5720.3707592165665, 5744.655320680772, 5778.16216648592, 5841.4450627190345, 5628.409017053151, 5684.459976302244, 5721.056025755704, 5738.225339579103, 5833.854153646193], "value": 5110.779211612998, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.5717721432007, 344.1877169879085, 344.4127762165508, 348.13314846033353, 352.6279774837547, 5817.389174136718, 5876.911846322303, 5916.26046744157, 5936.079907614316, 5953.434423729739, 5797.449242321973, 5816.447437493442, 5833.212516310296, 5878.323992740836, 5883.735231914563, 4109.363048727452, 4438.667099967515, 4469.955300447003, 4472.195004899117, 4513.0, 4500.347449619803, 4500.482444518873, 4501.122281155176, 4524.619990902774, 4545.499995000548, 4474.418325617665, 4494.595486406222, 4514.210013247669, 4517.977410112945, 4523.231050721369, 4248.851290204843, 4461.39771130898, 4490.461144662661, 4506.369108324837, 4509.706869053533, 3927.9198220489593, 3932.488776459071, 3932.705047121449, 3934.0, 3936.547297060846, 5694.430556944314, 5696.857578560528, 5700.743466544015, 5703.058995265817, 5722.0, 4900.264960255954, 5062.417821950486, 5126.5898728101665, 5151.73782423305, 5156.948430515722, 6089.969550152266, 6094.481969032638, 6123.755049798003, 6142.170806941051, 6173.84565385869, 4085.55058943516, 4290.914181716379, 4298.591633794785, 4333.8699839004885, 4339.804708788112, 6230.501559875244, 6270.78052268173, 6297.2128483939505, 6336.398042185985, 6336.52476064297, 4439.489458712224, 4444.8444304449185, 4451.888702782457, 4468.843590474317, 4471.5081341052455, 4357.847475338348, 4475.865724028285, 4508.0533088051225, 4522.954770452254, 4525.366448697185, 5085.389753229636, 5126.7180305083575, 5133.845984620468, 5148.17629179337, 5162.406323272871, 6097.420745029215, 6118.78584249558, 6200.286966998763, 6228.03465462854, 6247.2815626202655, 1485.1608841004797, 1522.4595268679682, 1531.3950989359141, 1549.132485807951, 1551.7206902757612, 956.3305686019814, 980.1766516126488, 1033.984490232632, 1053.1206442620344, 1054.8997845204694, 5881.617694849821, 5881.8826022208295, 5889.970550147222, 5905.881882362329, 5947.345791962881, 6213.782517611862, 6220.471259942865, 6283.2460104787715, 6283.6858157091965, 6284.560080794392, 5772.682502462405, 5877.500412464989, 5916.26046744157, 5934.317553481319, 5937.042569454554, 3309.834508274577, 3315.154635567963, 3340.346528468424, 3344.1806757344607, 3364.4616861302566, 6180.412860778219, 6414.390632889868, 6486.54594178403, 6528.869422611521, 6623.4038936495945, 6489.156409666713, 6504.24385415935, 6562.8359291018105, 6590.538662293593, 6627.536072474881, 6364.681765911779, 6542.499762627067, 6644.4020038196795, 6658.404461590783, 6662.533622646465, 6326.0, 6327.588706734047, 6354.555181137276, 6354.6822658867795, 6366.236051673829, 6164.722587483484, 6300.558960872695, 6302.180716506825, 6343.524235682435, 6357.427831495188, 6526.0, 6538.967305163444, 6549.639769812706, 6590.901136483052, 6597.670116494252, 4423.756693381766, 4473.261911784519, 4475.731456112644, 4479.440069991251, 4496.437945256843, 6191.925704888913, 6305.779297724557, 6365.2361716594305, 6446.194225721785, 6512.34876512345, 6141.109539116893, 6182.567220294536, 6192.81421557354, 6248.375162483715, 6249.78125765596, 6058.697065146813, 6207.317195108625, 6208.130861679459, 6214.9067763984485, 6251.937480625317, 5957.54040260139, 6066.4540191382985, 6105.358937311518, 6117.938820611737, 6118.694065296629, 6190.2571691397325, 6209.441150296495, 6280.937190628035, 6283.183186185766, 6323.272823625342, 5897.584579700927, 6062.0, 6131.908021379593, 6145.477634401126, 6158.846028849314], "value": 4661.623017717384, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [819.1194465949106, 838.660342561263, 847.5592691800264, 920.6271460058679, 947.1097168661457, 15094.0, 15542.22288885557, 15626.218689065558, 15665.295061722236, 15683.294251758669, 15911.44309949152, 16698.0, 16901.83098169018, 16906.323747050134, 16976.83023169768, 861.5046348349692, 877.0615441477621, 879.7932485865816, 883.3021912688968, 885.4908427654093, 893.6738090596917, 902.7066203483861, 905.3707673167119, 907.5825120444571, 908.582052255963, 956.5886668732443, 958.314804914486, 959.0888655777039, 959.4243453927622, 959.6593209410663, 948.2035090523993, 948.5826236455972, 949.6106596295521, 950.2920324358397, 950.6007476859701, 703.7396163419568, 703.8310805406717, 704.5279662626053, 704.6582407532343, 706.4172058052076, 17586.384476543386, 17890.91054544732, 17916.372926947624, 18020.90989545057, 18053.187606557738, 13933.79099313501, 14679.77980330296, 14801.0, 15909.806764492594, 16355.182240887909, 14583.343749531297, 14691.77962330566, 14839.851601483955, 14914.403423863032, 15128.470503532324, 4762.809487620491, 4798.47216806151, 4939.835970706194, 4947.455779864212, 4971.726555039471, 89455.0, 90373.54813225892, 90594.0, 94519.52740236255, 96930.0, 12560.937195313965, 12566.937165314115, 12578.433970471351, 12720.300383478812, 12721.0, 22521.436964075703, 22588.0, 22595.322140335815, 22676.546469070858, 22688.88655556712, 9316.627334906529, 9382.67160649374, 9432.0, 9437.575309111107, 9756.707298781048, 5288.550473209743, 5296.761645725952, 5304.92042619361, 5313.707746074003, 5413.566914646819, 3862.841147655748, 3953.584873588289, 3970.781607011642, 3975.1453437511072, 3986.621270979252, 681.2472218198918, 681.9965900170566, 691.0532570378513, 693.760652574871, 695.6382681005949, 676.6650507998572, 695.169272719106, 745.9780101261198, 755.6712829919003, 758.3402439877342, 9580.712578622653, 10141.695749127539, 10603.734906627396, 10715.678529644123, 10835.891641083646, 684.9794506164823, 697.1181455458849, 708.1785129250045, 739.4084732214208, 742.5210739073267, 4790.377250957354, 5137.33214682089, 5148.639595228373, 5188.273641690166, 5214.8957020860125, 107205.46397267963, 130016.08974390966, 131646.0, 132831.0, 134546.0, 110753.0, 111668.0, 112601.0, 113451.43274283576, 118289.0, 82149.58925205335, 82892.17107828845, 83295.16704832995, 90952.99999999868, 106049.0, 10312.535935882754, 10698.465076746288, 10921.126309895348, 11002.229843910849, 11135.0, 55428.44571554233, 55933.72033139808, 56001.71999139978, 56110.158347624005, 56527.15209271782, 72008.0, 80276.0, 82419.5879020601, 83853.58073209594, 84614.15385846309, 13503.59489215325, 13693.863061369259, 13835.10071845367, 13893.096948698303, 14427.278636067944, 15563.610909726895, 15687.843121569094, 16209.270582824038, 16707.164641768108, 16707.582310442336, 15866.7619985698, 15904.602384940468, 16622.418215362406, 17385.304587816347, 17584.0, 14074.718505630035, 15207.391704331703, 15424.922875385551, 15497.14765687898, 16120.596985075466, 14570.708585828012, 15431.922840385727, 15844.52466426009, 16011.279492422636, 16208.403695241692, 11601.0, 11751.529938802352, 12221.266723996589, 12527.812082818582, 12531.74936501283, 12492.875071249171, 12672.936635316764, 12793.872061279268, 13273.269970151734, 13657.590272291847], "value": 8413.403949200447, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1500.5000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 112.0, 104.0, 111.0, 112.0, 111.0, 109.0, 110.0, 109.0, 109.0], "value": 108.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 124.0, 155.0, 170.0, 117.0, 149.0, 155.0, 121.0, 177.0, 117.0], "value": 145.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 163.0, 162.0, 161.0, 161.0, 161.0, 160.0, 161.0, 162.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 74.0, 195.0, 76.0, 75.0, 74.0, 76.0, 164.0, 76.0], "value": 95.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 146.0, 83.0, 83.0, 85.0, 141.0, 84.0, 84.0, 132.0], "value": 100.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 118.0, 117.0, 118.0, 118.0, 120.0, 118.0, 117.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 146.0, 148.0, 148.0, 146.0, 147.0, 150.0, 148.0, 147.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 51.0, 51.0, 51.0, 54.0, 51.0, 51.0, 53.0, 52.0, 52.0], "value": 51.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 59.0, 59.0, 60.0, 59.0, 59.0, 59.0, 58.0, 59.0], "value": 59.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 72.0, 72.0, 72.0, 75.0, 78.0, 73.0, 81.0, 76.0, 72.0], "value": 74.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 124.0, 128.0, 117.0, 132.0, 117.0, 119.0, 129.0, 162.0, 128.0], "value": 129.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 149.0, 161.0, 147.0, 151.0, 149.0, 151.0, 152.0, 150.0, 158.0], "value": 151.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 61.0, 65.0, 62.0, 60.0, 60.0, 62.0, 60.0, 60.0, 60.0], "value": 61.9, "unit": "score"}]}]} 17:55:35 INFO - Return code: 0 17:55:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:55:35 ERROR - # TBPL SUCCESS # 17:55:35 INFO - Running post-action listener: _resource_record_post_action 17:55:35 INFO - [mozharness: 2016-08-13 00:55:35.302455Z] Finished run-tests step (success) 17:55:35 INFO - Running post-run listener: _resource_record_post_run 17:55:35 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 430080; Write bytes: 326201344; Read time: 128; Write time: 208436 17:55:35 INFO - TinderboxPrint: CPU usage
13.2% 17:55:35 INFO - TinderboxPrint: I/O read bytes / time
430,080 / 128 17:55:35 INFO - TinderboxPrint: I/O write bytes / time
326,201,344 / 208,436 17:55:35 INFO - TinderboxPrint: CPU idle
8,233.5 (86.8%) 17:55:35 INFO - TinderboxPrint: CPU user
1,197.6 (12.6%) 17:55:35 INFO - TinderboxPrint: Swap in / out
0 / 0 17:55:35 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 77058048; Read time: 0; Write time: 66804 17:55:35 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 425984; Write bytes: 246403072; Read time: 116; Write time: 141404 17:55:35 INFO - Running post-run listener: _upload_blobber_files 17:55:35 INFO - Blob upload gear active. 17:55:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:55:35 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 17:55:35 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'] 17:55:35 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 17:55:36 INFO - (blobuploader) - INFO - Open directory for files ... 17:55:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:55:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:55:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:55:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:55:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:55:37 INFO - (blobuploader) - INFO - Done attempting. 17:55:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:55:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:55:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:55:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:55:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:55:48 INFO - (blobuploader) - INFO - Done attempting. 17:55:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:55:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:55:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:55:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:55:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:55:49 INFO - (blobuploader) - INFO - Done attempting. 17:55:49 INFO - (blobuploader) - INFO - Iteration through files over. 17:55:49 INFO - Return code: 0 17:55:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:55:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:55:49 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/77b2321a5ed143e45d894dfaafeab36cdf55146721bfae6eb6a98f978d84f054935eba8b6b63a5ffbc9842baf3bf6fcb87ccdf50145020946e05e70ca9ffa88c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/11355cf45300dd3045b814ca6269851914d94ac5e9535884afa498a7476325f44fcce0ba7b34f14a9c1528fdacbb25c0556d9d3fd25e7bb18396bb1be37fed15", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/049a1c0dde4d554f6d00899d11989b758051a50127e97f702a2ca9c55113b143f9ddb0c5f9621057fe6656fc31c7852a44b98b708536693dcff718ec8f2d2660"} 17:55:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:55:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:55:49 INFO - Contents: 17:55:49 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/77b2321a5ed143e45d894dfaafeab36cdf55146721bfae6eb6a98f978d84f054935eba8b6b63a5ffbc9842baf3bf6fcb87ccdf50145020946e05e70ca9ffa88c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/11355cf45300dd3045b814ca6269851914d94ac5e9535884afa498a7476325f44fcce0ba7b34f14a9c1528fdacbb25c0556d9d3fd25e7bb18396bb1be37fed15", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/049a1c0dde4d554f6d00899d11989b758051a50127e97f702a2ca9c55113b143f9ddb0c5f9621057fe6656fc31c7852a44b98b708536693dcff718ec8f2d2660"} 17:55:49 INFO - Running post-run listener: copy_logs_to_upload_dir 17:55:49 INFO - Copying logs to upload dir... 17:55:49 INFO - mkdir: /builds/slave/test/build/upload/logs 17:55:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1684.896124 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 28 mins, 4 secs) (at 2016-08-12 17:55:49.105870) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-12 17:55:49.109835) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1471048061.579866-1675508048 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/77b2321a5ed143e45d894dfaafeab36cdf55146721bfae6eb6a98f978d84f054935eba8b6b63a5ffbc9842baf3bf6fcb87ccdf50145020946e05e70ca9ffa88c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/11355cf45300dd3045b814ca6269851914d94ac5e9535884afa498a7476325f44fcce0ba7b34f14a9c1528fdacbb25c0556d9d3fd25e7bb18396bb1be37fed15", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/049a1c0dde4d554f6d00899d11989b758051a50127e97f702a2ca9c55113b143f9ddb0c5f9621057fe6656fc31c7852a44b98b708536693dcff718ec8f2d2660"} build_url:https://queue.taskcluster.net/v1/task/F8jmALBQR2S2st2MIcys-A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011407 build_url: 'https://queue.taskcluster.net/v1/task/F8jmALBQR2S2st2MIcys-A/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/77b2321a5ed143e45d894dfaafeab36cdf55146721bfae6eb6a98f978d84f054935eba8b6b63a5ffbc9842baf3bf6fcb87ccdf50145020946e05e70ca9ffa88c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/11355cf45300dd3045b814ca6269851914d94ac5e9535884afa498a7476325f44fcce0ba7b34f14a9c1528fdacbb25c0556d9d3fd25e7bb18396bb1be37fed15", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/049a1c0dde4d554f6d00899d11989b758051a50127e97f702a2ca9c55113b143f9ddb0c5f9621057fe6656fc31c7852a44b98b708536693dcff718ec8f2d2660"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-12 17:55:49.135648) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 17:55:49.135972) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1471048061.579866-1675508048 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004515 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 17:55:49.221002) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-12 17:55:49.221316) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-12 17:55:49.221594) ========= ========= Total master_lag: 0.17 =========