builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-037 starttime: 1476466205.59 results: success (0) buildid: 20161014072435 builduid: 7e1fd950349947fb832cb9892e31249f revision: 6d65311378a748b84f98ede85d2c541addd8f266 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-14 10:30:05.585625) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-14 10:30:05.586105) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-14 10:30:05.586383) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-14 10:30:05.601003) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 10:30:05.601337) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1476466203.857261-1810195576 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-14 10:30:05-- 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: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2016-10-14 10:30:05 (222 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.127008 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 10:30:05.741874) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 10:30:05.742187) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1476466203.857261-1810195576 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013137 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 10:30:05.791938) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 10:30:05.792289) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 6d65311378a748b84f98ede85d2c541addd8f266 --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-beta --rev 6d65311378a748b84f98ede85d2c541addd8f266 --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=56c518bb7cbc29fb3c9463e2000001c4-1476466203.857261-1810195576 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-14 10:30:05,848 truncating revision to first 12 chars 2016-10-14 10:30:05,848 Setting DEBUG logging. 2016-10-14 10:30:05,848 attempt 1/10 2016-10-14 10:30:05,848 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/6d65311378a7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-14 10:30:06,150 unpacking tar archive at: mozilla-beta-6d65311378a7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.621942 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 10:30:06.427837) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-14 10:30:06.428170) ========= script_repo_revision: 6d65311378a748b84f98ede85d2c541addd8f266 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-14 10:30:06.428546) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-14 10:30:06.428822) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-14 10:30:06.438291) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 51 secs) (at 2016-10-14 10:30:06.438683) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=56c518bb7cbc29fb3c9463e2000001c4-1476466203.857261-1810195576 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:30:06 INFO - MultiFileLogger online at 20161014 10:30:06 in /builds/slave/test 10:30:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 10:30:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:30:06 INFO - {'append_to_log': False, 10:30:06 INFO - 'base_work_dir': '/builds/slave/test', 10:30:06 INFO - 'blob_upload_branch': 'Mozilla-Beta', 10:30:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:30:06 INFO - 'branch': 'Mozilla-Beta', 10:30:06 INFO - 'buildbot_json_path': 'buildprops.json', 10:30:06 INFO - 'config_files': ('talos/linux_config.py',), 10:30:06 INFO - 'default_actions': ('clobber', 10:30:06 INFO - 'read-buildbot-config', 10:30:06 INFO - 'download-and-extract', 10:30:06 INFO - 'populate-webroot', 10:30:06 INFO - 'create-virtualenv', 10:30:06 INFO - 'install', 10:30:06 INFO - 'run-tests'), 10:30:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:30:06 INFO - 'download_minidump_stackwalk': True, 10:30:06 INFO - 'download_symbols': 'ondemand', 10:30:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:30:06 INFO - 'tooltool.py': '/tools/tooltool.py', 10:30:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:30:06 INFO - '/tools/misc-python/virtualenv.py')}, 10:30:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:30:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:30:06 INFO - 'installer_path': 'installer.exe', 10:30:06 INFO - 'log_level': 'info', 10:30:06 INFO - 'log_name': 'talos', 10:30:06 INFO - 'log_to_console': True, 10:30:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:30:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:30:06 INFO - 'opt_config_files': (), 10:30:06 INFO - 'pip_index': False, 10:30:06 INFO - 'sps_profile': False, 10:30:06 INFO - 'sps_profile_interval': 0, 10:30:06 INFO - 'suite': 'dromaeojs-e10s', 10:30:06 INFO - 'system_bits': '32', 10:30:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:30:06 INFO - 'title': 'talos-linux64-ix-037', 10:30:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:30:06 INFO - 'use_talos_json': True, 10:30:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:30:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:30:06 INFO - 'work_dir': 'build'} 10:30:06 INFO - [mozharness: 2016-10-14 17:30:06.592900Z] Running clobber step. 10:30:06 INFO - Running pre-action listener: _resource_record_pre_action 10:30:06 INFO - Running main action method: clobber 10:30:06 INFO - rmtree: /builds/slave/test/build 10:30:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:30:07 INFO - Running post-action listener: _resource_record_post_action 10:30:07 INFO - [mozharness: 2016-10-14 17:30:07.044475Z] Finished clobber step (success) 10:30:07 INFO - [mozharness: 2016-10-14 17:30:07.044574Z] Running read-buildbot-config step. 10:30:07 INFO - Running pre-action listener: _resource_record_pre_action 10:30:07 INFO - Running main action method: read_buildbot_config 10:30:07 INFO - Using buildbot properties: 10:30:07 INFO - { 10:30:07 INFO - "project": "", 10:30:07 INFO - "product": "firefox", 10:30:07 INFO - "script_repo_revision": "production", 10:30:07 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 10:30:07 INFO - "repository": "", 10:30:07 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 10:30:07 INFO - "buildid": "20161014072435", 10:30:07 INFO - "pgo_build": "True", 10:30:07 INFO - "basedir": "/builds/slave/test", 10:30:07 INFO - "buildnumber": 162, 10:30:07 INFO - "slavename": "talos-linux64-ix-037", 10:30:07 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:30:07 INFO - "platform": "ubuntu64_hw", 10:30:07 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 10:30:07 INFO - "branch": "mozilla-beta", 10:30:07 INFO - "repo_path": "releases/mozilla-beta", 10:30:07 INFO - "revision": "6d65311378a748b84f98ede85d2c541addd8f266", 10:30:07 INFO - "stage_platform": "linux64-pgo", 10:30:07 INFO - "builduid": "7e1fd950349947fb832cb9892e31249f", 10:30:07 INFO - "slavebuilddir": "test" 10:30:07 INFO - } 10:30:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/G4cSmpsWT4Ofd0HELKBbuQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2. 10:30:07 INFO - Running post-action listener: _resource_record_post_action 10:30:07 INFO - [mozharness: 2016-10-14 17:30:07.047247Z] Finished read-buildbot-config step (success) 10:30:07 INFO - [mozharness: 2016-10-14 17:30:07.047337Z] Running download-and-extract step. 10:30:07 INFO - Running pre-action listener: _resource_record_pre_action 10:30:07 INFO - Running main action method: download_and_extract 10:30:07 INFO - mkdir: /builds/slave/test/build/tests 10:30:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:30:07 INFO - https://queue.taskcluster.net/v1/task/G4cSmpsWT4Ofd0HELKBbuQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:30:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G4cSmpsWT4Ofd0HELKBbuQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 10:30:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G4cSmpsWT4Ofd0HELKBbuQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 10:30:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G4cSmpsWT4Ofd0HELKBbuQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 10:30:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G4cSmpsWT4Ofd0HELKBbuQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 10:30:07 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G4cSmpsWT4Ofd0HELKBbuQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 10:30:07 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 10:30:07 INFO - retry: Failed, sleeping 30 seconds before retrying 10:30:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G4cSmpsWT4Ofd0HELKBbuQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json'}, attempt #2 10:30:37 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G4cSmpsWT4Ofd0HELKBbuQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 10:30:37 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 10:30:37 INFO - retry: Failed, sleeping 60 seconds before retrying 10:31:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G4cSmpsWT4Ofd0HELKBbuQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json'}, attempt #3 10:31:37 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G4cSmpsWT4Ofd0HELKBbuQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 10:31:37 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 10:31:37 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G4cSmpsWT4Ofd0HELKBbuQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json! 10:31:37 INFO - Caught exception: HTTP Error 404: Not Found 10:31:37 INFO - Caught exception: HTTP Error 404: Not Found 10:31:37 INFO - Caught exception: HTTP Error 404: Not Found 10:31:37 INFO - trying https://queue.taskcluster.net/v1/task/G4cSmpsWT4Ofd0HELKBbuQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 10:31:37 INFO - Downloading https://queue.taskcluster.net/v1/task/G4cSmpsWT4Ofd0HELKBbuQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 10:31:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/G4cSmpsWT4Ofd0HELKBbuQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 10:31:37 INFO - Downloaded 1327 bytes. 10:31:37 INFO - Reading from file /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 10:31:37 INFO - Using the following test package requirements: 10:31:37 INFO - {u'common': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'], 10:31:37 INFO - u'cppunittest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 10:31:37 INFO - u'firefox-50.0.en-US.linux-x86_64.cppunittest.tests.zip'], 10:31:37 INFO - u'gtest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 10:31:37 INFO - u'firefox-50.0.en-US.linux-x86_64.gtest.tests.zip'], 10:31:37 INFO - u'jittest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 10:31:37 INFO - u'jsshell-linux-x86_64.zip'], 10:31:37 INFO - u'mochitest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 10:31:37 INFO - u'firefox-50.0.en-US.linux-x86_64.mochitest.tests.zip'], 10:31:37 INFO - u'mozbase': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'], 10:31:37 INFO - u'reftest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 10:31:37 INFO - u'firefox-50.0.en-US.linux-x86_64.reftest.tests.zip'], 10:31:37 INFO - u'talos': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 10:31:37 INFO - u'firefox-50.0.en-US.linux-x86_64.talos.tests.zip'], 10:31:37 INFO - u'web-platform': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 10:31:37 INFO - u'firefox-50.0.en-US.linux-x86_64.web-platform.tests.zip'], 10:31:37 INFO - u'xpcshell': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 10:31:37 INFO - u'firefox-50.0.en-US.linux-x86_64.xpcshell.tests.zip']} 10:31:37 INFO - Downloading packages: [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:31:37 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')]} 10:31:37 INFO - https://queue.taskcluster.net/v1/task/G4cSmpsWT4Ofd0HELKBbuQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:31:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G4cSmpsWT4Ofd0HELKBbuQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 10:31:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G4cSmpsWT4Ofd0HELKBbuQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 10:31:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G4cSmpsWT4Ofd0HELKBbuQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 10:31:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G4cSmpsWT4Ofd0HELKBbuQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:31:37 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G4cSmpsWT4Ofd0HELKBbuQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 10:31:37 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 10:31:37 INFO - retry: Failed, sleeping 30 seconds before retrying 10:32:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G4cSmpsWT4Ofd0HELKBbuQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #2 10:32:07 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G4cSmpsWT4Ofd0HELKBbuQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 10:32:07 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 10:32:07 INFO - retry: Failed, sleeping 60 seconds before retrying 10:33:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G4cSmpsWT4Ofd0HELKBbuQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #3 10:33:07 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G4cSmpsWT4Ofd0HELKBbuQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 10:33:07 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 10:33:07 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G4cSmpsWT4Ofd0HELKBbuQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip! 10:33:07 INFO - Caught exception: HTTP Error 404: Not Found 10:33:07 INFO - Caught exception: HTTP Error 404: Not Found 10:33:07 INFO - Caught exception: HTTP Error 404: Not Found 10:33:07 INFO - trying https://queue.taskcluster.net/v1/task/G4cSmpsWT4Ofd0HELKBbuQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 10:33:07 INFO - Downloading https://queue.taskcluster.net/v1/task/G4cSmpsWT4Ofd0HELKBbuQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 10:33:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/G4cSmpsWT4Ofd0HELKBbuQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:33:08 INFO - Downloaded 21773321 bytes. 10:33:08 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:33:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:33:09 INFO - Return code: 0 10:33:09 INFO - Downloading packages: [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:33:09 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')]} 10:33:09 INFO - https://queue.taskcluster.net/v1/task/G4cSmpsWT4Ofd0HELKBbuQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:33:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G4cSmpsWT4Ofd0HELKBbuQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 10:33:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G4cSmpsWT4Ofd0HELKBbuQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 10:33:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G4cSmpsWT4Ofd0HELKBbuQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 10:33:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G4cSmpsWT4Ofd0HELKBbuQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:33:09 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G4cSmpsWT4Ofd0HELKBbuQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 10:33:09 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 10:33:09 INFO - retry: Failed, sleeping 30 seconds before retrying 10:33:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G4cSmpsWT4Ofd0HELKBbuQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #2 10:33:39 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G4cSmpsWT4Ofd0HELKBbuQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 10:33:39 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 10:33:39 INFO - retry: Failed, sleeping 60 seconds before retrying 10:34:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G4cSmpsWT4Ofd0HELKBbuQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #3 10:34:40 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G4cSmpsWT4Ofd0HELKBbuQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 10:34:40 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 10:34:40 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G4cSmpsWT4Ofd0HELKBbuQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip! 10:34:40 INFO - Caught exception: HTTP Error 404: Not Found 10:34:40 INFO - Caught exception: HTTP Error 404: Not Found 10:34:40 INFO - Caught exception: HTTP Error 404: Not Found 10:34:40 INFO - trying https://queue.taskcluster.net/v1/task/G4cSmpsWT4Ofd0HELKBbuQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 10:34:40 INFO - Downloading https://queue.taskcluster.net/v1/task/G4cSmpsWT4Ofd0HELKBbuQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 10:34:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/G4cSmpsWT4Ofd0HELKBbuQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:34:40 INFO - Downloaded 21773321 bytes. 10:34:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:34:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:34:42 INFO - Return code: 0 10:34:42 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')]} 10:34:42 INFO - https://queue.taskcluster.net/v1/task/G4cSmpsWT4Ofd0HELKBbuQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:34:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G4cSmpsWT4Ofd0HELKBbuQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 10:34:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G4cSmpsWT4Ofd0HELKBbuQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 10:34:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G4cSmpsWT4Ofd0HELKBbuQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 10:34:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G4cSmpsWT4Ofd0HELKBbuQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:34:42 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G4cSmpsWT4Ofd0HELKBbuQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 10:34:42 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 10:34:42 INFO - retry: Failed, sleeping 30 seconds before retrying 10:35:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G4cSmpsWT4Ofd0HELKBbuQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #2 10:35:12 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G4cSmpsWT4Ofd0HELKBbuQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 10:35:12 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 10:35:12 INFO - retry: Failed, sleeping 60 seconds before retrying 10:36:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G4cSmpsWT4Ofd0HELKBbuQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #3 10:36:12 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G4cSmpsWT4Ofd0HELKBbuQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 10:36:12 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 10:36:12 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G4cSmpsWT4Ofd0HELKBbuQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip! 10:36:12 INFO - Caught exception: HTTP Error 404: Not Found 10:36:12 INFO - Caught exception: HTTP Error 404: Not Found 10:36:12 INFO - Caught exception: HTTP Error 404: Not Found 10:36:12 INFO - trying https://queue.taskcluster.net/v1/task/G4cSmpsWT4Ofd0HELKBbuQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 10:36:12 INFO - Downloading https://queue.taskcluster.net/v1/task/G4cSmpsWT4Ofd0HELKBbuQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 10:36:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/G4cSmpsWT4Ofd0HELKBbuQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:36:13 INFO - Downloaded 14413762 bytes. 10:36:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:36:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 10:36:13 INFO - Return code: 0 10:36:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:36:13 INFO - https://queue.taskcluster.net/v1/task/G4cSmpsWT4Ofd0HELKBbuQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:36:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G4cSmpsWT4Ofd0HELKBbuQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 10:36:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G4cSmpsWT4Ofd0HELKBbuQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 10:36:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G4cSmpsWT4Ofd0HELKBbuQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 10:36:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G4cSmpsWT4Ofd0HELKBbuQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:36:13 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G4cSmpsWT4Ofd0HELKBbuQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 10:36:13 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 10:36:13 INFO - retry: Failed, sleeping 30 seconds before retrying 10:36:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G4cSmpsWT4Ofd0HELKBbuQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2'}, attempt #2 10:36:43 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G4cSmpsWT4Ofd0HELKBbuQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 10:36:43 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 10:36:43 INFO - retry: Failed, sleeping 60 seconds before retrying 10:37:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G4cSmpsWT4Ofd0HELKBbuQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2'}, attempt #3 10:37:43 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G4cSmpsWT4Ofd0HELKBbuQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 10:37:43 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 10:37:43 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G4cSmpsWT4Ofd0HELKBbuQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2! 10:37:43 INFO - Caught exception: HTTP Error 404: Not Found 10:37:43 INFO - Caught exception: HTTP Error 404: Not Found 10:37:43 INFO - Caught exception: HTTP Error 404: Not Found 10:37:43 INFO - trying https://queue.taskcluster.net/v1/task/G4cSmpsWT4Ofd0HELKBbuQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 10:37:43 INFO - Downloading https://queue.taskcluster.net/v1/task/G4cSmpsWT4Ofd0HELKBbuQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 10:37:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/G4cSmpsWT4Ofd0HELKBbuQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:37:44 INFO - Downloaded 56776997 bytes. 10:37:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/G4cSmpsWT4Ofd0HELKBbuQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 10:37:44 INFO - mkdir: /builds/slave/test/properties 10:37:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:37:44 INFO - Writing to file /builds/slave/test/properties/build_url 10:37:44 INFO - Contents: 10:37:44 INFO - build_url:https://queue.taskcluster.net/v1/task/G4cSmpsWT4Ofd0HELKBbuQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 10:37:45 INFO - Running post-action listener: _resource_record_post_action 10:37:45 INFO - Running post-action listener: set_extra_try_arguments 10:37:45 INFO - [mozharness: 2016-10-14 17:37:45.425629Z] Finished download-and-extract step (success) 10:37:45 INFO - [mozharness: 2016-10-14 17:37:45.425862Z] Running populate-webroot step. 10:37:45 INFO - Running pre-action listener: _resource_record_pre_action 10:37:45 INFO - Running main action method: populate_webroot 10:37:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:37:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:37:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:37:45 INFO - '--tppagecycles', 10:37:45 INFO - '7'], 10:37:45 INFO - 'tests': ['tsvgm']}}, 10:37:45 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:37:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:37:45 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:37:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:37:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:37:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:37:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:37:45 INFO - 'talos_options': ['--disable-e10s'], 10:37:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:37:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:37:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:37:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:37:45 INFO - 'talos_options': ['--disable-e10s'], 10:37:45 INFO - 'tests': ['damp', 'tps']}, 10:37:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:37:45 INFO - 'tests': ['damp', 'tps']}, 10:37:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:37:45 INFO - 'tests': ['dromaeo_dom']}, 10:37:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:37:45 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:37:45 INFO - 'tests': ['basic_compositor_video']}, 10:37:45 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:37:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:37:45 INFO - 'tests': ['a11yr', 10:37:45 INFO - 'ts_paint', 10:37:45 INFO - 'tpaint', 10:37:45 INFO - 'sessionrestore', 10:37:45 INFO - 'sessionrestore_no_auto_restore', 10:37:45 INFO - 'tabpaint']}, 10:37:45 INFO - 'other-e10s': {'tests': ['a11yr', 10:37:45 INFO - 'ts_paint', 10:37:45 INFO - 'tpaint', 10:37:45 INFO - 'sessionrestore', 10:37:45 INFO - 'sessionrestore_no_auto_restore', 10:37:45 INFO - 'tabpaint']}, 10:37:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:37:45 INFO - 'ts_paint', 10:37:45 INFO - 'tpaint', 10:37:45 INFO - 'sessionrestore', 10:37:45 INFO - 'sessionrestore_no_auto_restore', 10:37:45 INFO - 'tabpaint']}, 10:37:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:37:45 INFO - 'ts_paint', 10:37:45 INFO - 'tpaint', 10:37:45 INFO - 'sessionrestore', 10:37:45 INFO - 'sessionrestore_no_auto_restore', 10:37:45 INFO - 'tabpaint']}, 10:37:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:37:45 INFO - 'tests': ['a11yr', 10:37:45 INFO - 'ts_paint', 10:37:45 INFO - 'tpaint', 10:37:45 INFO - 'sessionrestore', 10:37:45 INFO - 'sessionrestore_no_auto_restore', 10:37:45 INFO - 'tabpaint']}, 10:37:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:37:45 INFO - 'tests': ['a11yr', 10:37:45 INFO - 'ts_paint', 10:37:45 INFO - 'tpaint', 10:37:45 INFO - 'sessionrestore', 10:37:45 INFO - 'sessionrestore_no_auto_restore', 10:37:45 INFO - 'tabpaint']}, 10:37:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:37:45 INFO - 'tests': ['tsvgx', 10:37:45 INFO - 'tsvgr_opacity', 10:37:45 INFO - 'tart', 10:37:45 INFO - 'tscrollx', 10:37:45 INFO - 'cart']}, 10:37:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:37:45 INFO - 'tsvgr_opacity', 10:37:45 INFO - 'tart', 10:37:45 INFO - 'tscrollx', 10:37:45 INFO - 'cart']}, 10:37:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:37:45 INFO - 'talos_options': ['--disable-e10s'], 10:37:45 INFO - 'tests': ['tp5o']}, 10:37:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:37:45 INFO - 'tests': ['tp5o']}, 10:37:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:37:45 INFO - 'talos_options': ['--disable-e10s', 10:37:45 INFO - '--xperf_path', 10:37:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:37:45 INFO - 'tests': ['tp5n']}, 10:37:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:37:45 INFO - 'talos_options': ['--xperf_path', 10:37:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:37:45 INFO - 'tests': ['tp5n']}}, 10:37:45 INFO - 'talos.zip': {'path': '', 10:37:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:37:45 INFO - Running post-action listener: _resource_record_post_action 10:37:45 INFO - [mozharness: 2016-10-14 17:37:45.446405Z] Finished populate-webroot step (success) 10:37:45 INFO - [mozharness: 2016-10-14 17:37:45.446494Z] Running create-virtualenv step. 10:37:45 INFO - Running pre-action listener: _resource_record_pre_action 10:37:45 INFO - Running main action method: create_virtualenv 10:37:45 INFO - Creating virtualenv /builds/slave/test/build/venv 10:37:45 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 10:37:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:37:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:37:45 INFO - Using real prefix '/usr' 10:37:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:37:46 INFO - Installing distribute.............................................................................................................................................................................................done. 10:37:47 INFO - Installing pip.................done. 10:37:48 INFO - Return code: 0 10:37:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:37:48 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')]} 10:37:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:37:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:37:48 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')]} 10:37:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:37:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:37:48 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 0x24a0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26cf400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x275e570>, '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 0x275f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x275f900>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1476466203.857261-1810195576', '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 10:37:48 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 10:37:48 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 10:37:48 INFO - Using env: {'DISPLAY': ':0', 10:37:48 INFO - 'HOME': '/home/cltbld', 10:37:48 INFO - 'LANG': 'en_US.UTF-8', 10:37:48 INFO - 'LANGUAGE': 'en_US:en', 10:37:48 INFO - 'LOGNAME': 'cltbld', 10:37:48 INFO - 'MAIL': '/var/mail/cltbld', 10:37:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:37:48 INFO - 'MOZ_NO_REMOTE': '1', 10:37:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:37:48 INFO - 'NO_EM_RESTART': '1', 10:37:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:37:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:37:48 INFO - 'PWD': '/builds/slave/test', 10:37:48 INFO - 'SHELL': '/bin/bash', 10:37:48 INFO - 'SHLVL': '1', 10:37:48 INFO - 'TERM': 'linux', 10:37:48 INFO - 'TMOUT': '86400', 10:37:48 INFO - 'USER': 'cltbld', 10:37:48 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1476466203.857261-1810195576', 10:37:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:37:48 INFO - '_': '/tools/buildbot/bin/python'} 10:37:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:37:48 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 10:37:48 INFO - Cleaning up... 10:37:48 INFO - Return code: 0 10:37:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:37:48 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')]} 10:37:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:37:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:37:48 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')]} 10:37:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:37:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:37:48 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 0x24a0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26cf400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x275e570>, '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 0x275f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x275f900>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1476466203.857261-1810195576', '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 10:37:48 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 10:37:48 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 10:37:48 INFO - Using env: {'DISPLAY': ':0', 10:37:48 INFO - 'HOME': '/home/cltbld', 10:37:48 INFO - 'LANG': 'en_US.UTF-8', 10:37:48 INFO - 'LANGUAGE': 'en_US:en', 10:37:48 INFO - 'LOGNAME': 'cltbld', 10:37:48 INFO - 'MAIL': '/var/mail/cltbld', 10:37:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:37:48 INFO - 'MOZ_NO_REMOTE': '1', 10:37:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:37:48 INFO - 'NO_EM_RESTART': '1', 10:37:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:37:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:37:48 INFO - 'PWD': '/builds/slave/test', 10:37:48 INFO - 'SHELL': '/bin/bash', 10:37:48 INFO - 'SHLVL': '1', 10:37:48 INFO - 'TERM': 'linux', 10:37:48 INFO - 'TMOUT': '86400', 10:37:48 INFO - 'USER': 'cltbld', 10:37:48 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1476466203.857261-1810195576', 10:37:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:37:48 INFO - '_': '/tools/buildbot/bin/python'} 10:37:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:37:48 INFO - Downloading/unpacking psutil>=3.1.1 10:37:48 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 10:37:48 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 10:37:48 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 10:37:48 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 10:37:48 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 10:37:48 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 10:37:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:37:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:37:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:37:50 INFO - Installing collected packages: psutil 10:37:50 INFO - Running setup.py install for psutil 10:37:50 INFO - building 'psutil._psutil_linux' extension 10:37:50 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 10:37:50 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 10:37:50 INFO - building 'psutil._psutil_posix' extension 10:37:50 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 10:37:50 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 10:37:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:37:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:37:51 INFO - Successfully installed psutil 10:37:51 INFO - Cleaning up... 10:37:51 INFO - Return code: 0 10:37:51 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:37:51 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')]} 10:37:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:37:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:37:51 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')]} 10:37:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:37:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:37:51 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 0x24a0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26cf400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x275e570>, '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 0x275f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x275f900>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1476466203.857261-1810195576', '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 10:37:51 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 10:37:51 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 10:37:51 INFO - Using env: {'DISPLAY': ':0', 10:37:51 INFO - 'HOME': '/home/cltbld', 10:37:51 INFO - 'LANG': 'en_US.UTF-8', 10:37:51 INFO - 'LANGUAGE': 'en_US:en', 10:37:51 INFO - 'LOGNAME': 'cltbld', 10:37:51 INFO - 'MAIL': '/var/mail/cltbld', 10:37:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:37:51 INFO - 'MOZ_NO_REMOTE': '1', 10:37:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:37:51 INFO - 'NO_EM_RESTART': '1', 10:37:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:37:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:37:51 INFO - 'PWD': '/builds/slave/test', 10:37:51 INFO - 'SHELL': '/bin/bash', 10:37:51 INFO - 'SHLVL': '1', 10:37:51 INFO - 'TERM': 'linux', 10:37:51 INFO - 'TMOUT': '86400', 10:37:51 INFO - 'USER': 'cltbld', 10:37:51 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1476466203.857261-1810195576', 10:37:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:37:51 INFO - '_': '/tools/buildbot/bin/python'} 10:37:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:37:51 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:37:51 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 10:37:51 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 10:37:51 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 10:37:51 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 10:37:51 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 10:37:51 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 10:37:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:37:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:37:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:37:53 INFO - Installing collected packages: mozsystemmonitor 10:37:53 INFO - Running setup.py install for mozsystemmonitor 10:37:53 INFO - Successfully installed mozsystemmonitor 10:37:53 INFO - Cleaning up... 10:37:53 INFO - Return code: 0 10:37:53 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:37:53 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')]} 10:37:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:37:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:37:53 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')]} 10:37:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:37:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:37:53 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 0x24a0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26cf400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x275e570>, '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 0x275f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x275f900>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1476466203.857261-1810195576', '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 10:37:53 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 10:37:53 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 10:37:53 INFO - Using env: {'DISPLAY': ':0', 10:37:53 INFO - 'HOME': '/home/cltbld', 10:37:53 INFO - 'LANG': 'en_US.UTF-8', 10:37:53 INFO - 'LANGUAGE': 'en_US:en', 10:37:53 INFO - 'LOGNAME': 'cltbld', 10:37:53 INFO - 'MAIL': '/var/mail/cltbld', 10:37:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:37:53 INFO - 'MOZ_NO_REMOTE': '1', 10:37:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:37:53 INFO - 'NO_EM_RESTART': '1', 10:37:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:37:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:37:53 INFO - 'PWD': '/builds/slave/test', 10:37:53 INFO - 'SHELL': '/bin/bash', 10:37:53 INFO - 'SHLVL': '1', 10:37:53 INFO - 'TERM': 'linux', 10:37:53 INFO - 'TMOUT': '86400', 10:37:53 INFO - 'USER': 'cltbld', 10:37:53 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1476466203.857261-1810195576', 10:37:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:37:53 INFO - '_': '/tools/buildbot/bin/python'} 10:37:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:37:53 INFO - Downloading/unpacking jsonschema==2.5.1 10:37:53 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 10:37:53 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 10:37:53 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 10:37:53 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 10:37:53 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 10:37:53 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 10:37:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:37:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:37:55 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 10:37:55 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 10:37:55 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 10:37:55 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 10:37:55 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 10:37:55 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 10:37:55 INFO - Downloading functools32-3.2.3-2.tar.gz 10:37:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:37:55 INFO - warning: no files found matching '*.txt' 10:37:55 INFO - no previously-included directories found matching 'build' 10:37:55 INFO - no previously-included directories found matching 'dist' 10:37:55 INFO - no previously-included directories found matching '.git*' 10:37:55 INFO - Installing collected packages: jsonschema, functools32 10:37:55 INFO - Running setup.py install for functools32 10:37:55 INFO - warning: no files found matching '*.txt' 10:37:55 INFO - no previously-included directories found matching 'build' 10:37:55 INFO - no previously-included directories found matching 'dist' 10:37:55 INFO - no previously-included directories found matching '.git*' 10:37:55 INFO - Successfully installed jsonschema functools32 10:37:55 INFO - Cleaning up... 10:37:56 INFO - Return code: 0 10:37:56 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:37:56 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')]} 10:37:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:37:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:37:56 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')]} 10:37:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:37:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:37:56 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 0x24a0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26cf400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x275e570>, '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 0x275f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x275f900>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1476466203.857261-1810195576', '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 10:37:56 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 10:37:56 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 10:37:56 INFO - Using env: {'DISPLAY': ':0', 10:37:56 INFO - 'HOME': '/home/cltbld', 10:37:56 INFO - 'LANG': 'en_US.UTF-8', 10:37:56 INFO - 'LANGUAGE': 'en_US:en', 10:37:56 INFO - 'LOGNAME': 'cltbld', 10:37:56 INFO - 'MAIL': '/var/mail/cltbld', 10:37:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:37:56 INFO - 'MOZ_NO_REMOTE': '1', 10:37:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:37:56 INFO - 'NO_EM_RESTART': '1', 10:37:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:37:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:37:56 INFO - 'PWD': '/builds/slave/test', 10:37:56 INFO - 'SHELL': '/bin/bash', 10:37:56 INFO - 'SHLVL': '1', 10:37:56 INFO - 'TERM': 'linux', 10:37:56 INFO - 'TMOUT': '86400', 10:37:56 INFO - 'USER': 'cltbld', 10:37:56 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1476466203.857261-1810195576', 10:37:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:37:56 INFO - '_': '/tools/buildbot/bin/python'} 10:37:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:37:56 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:37:56 INFO - Cleaning up... 10:37:56 INFO - Return code: 0 10:37:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:37:56 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')]} 10:37:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:37:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:37:56 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')]} 10:37:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:37:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:37:56 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 0x24a0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26cf400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x275e570>, '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 0x275f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x275f900>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1476466203.857261-1810195576', '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 10:37:56 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 10:37:56 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 10:37:56 INFO - Using env: {'DISPLAY': ':0', 10:37:56 INFO - 'HOME': '/home/cltbld', 10:37:56 INFO - 'LANG': 'en_US.UTF-8', 10:37:56 INFO - 'LANGUAGE': 'en_US:en', 10:37:56 INFO - 'LOGNAME': 'cltbld', 10:37:56 INFO - 'MAIL': '/var/mail/cltbld', 10:37:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:37:56 INFO - 'MOZ_NO_REMOTE': '1', 10:37:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:37:56 INFO - 'NO_EM_RESTART': '1', 10:37:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:37:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:37:56 INFO - 'PWD': '/builds/slave/test', 10:37:56 INFO - 'SHELL': '/bin/bash', 10:37:56 INFO - 'SHLVL': '1', 10:37:56 INFO - 'TERM': 'linux', 10:37:56 INFO - 'TMOUT': '86400', 10:37:56 INFO - 'USER': 'cltbld', 10:37:56 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1476466203.857261-1810195576', 10:37:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:37:56 INFO - '_': '/tools/buildbot/bin/python'} 10:37:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:37:56 INFO - Downloading/unpacking blobuploader==1.2.4 10:37:56 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 10:37:56 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 10:37:56 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 10:37:56 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 10:37:56 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 10:37:56 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 10:37:58 INFO - Downloading blobuploader-1.2.4.tar.gz 10:37:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:37:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:37:58 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 10:37:58 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 10:37:58 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 10:37:58 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 10:37:58 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 10:37:58 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 10:37:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:37:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:37:58 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 10:37:58 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 10:37:58 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 10:37:58 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 10:37:58 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 10:37:58 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 10:37:59 INFO - Downloading docopt-0.6.1.tar.gz 10:37:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:37:59 INFO - Installing collected packages: blobuploader, requests, docopt 10:37:59 INFO - Running setup.py install for blobuploader 10:37:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:37:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:37:59 INFO - Running setup.py install for requests 10:37:59 INFO - Running setup.py install for docopt 10:37:59 INFO - Successfully installed blobuploader requests docopt 10:37:59 INFO - Cleaning up... 10:37:59 INFO - Return code: 0 10:37:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:37:59 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')]} 10:37:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:37:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:37:59 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')]} 10:37:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:37:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:37:59 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 0x24a0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26cf400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x275e570>, '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 0x275f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x275f900>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1476466203.857261-1810195576', '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 10:37:59 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 10:37:59 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 10:37:59 INFO - Using env: {'DISPLAY': ':0', 10:37:59 INFO - 'HOME': '/home/cltbld', 10:37:59 INFO - 'LANG': 'en_US.UTF-8', 10:37:59 INFO - 'LANGUAGE': 'en_US:en', 10:37:59 INFO - 'LOGNAME': 'cltbld', 10:37:59 INFO - 'MAIL': '/var/mail/cltbld', 10:37:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:37:59 INFO - 'MOZ_NO_REMOTE': '1', 10:37:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:37:59 INFO - 'NO_EM_RESTART': '1', 10:37:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:37:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:37:59 INFO - 'PWD': '/builds/slave/test', 10:37:59 INFO - 'SHELL': '/bin/bash', 10:37:59 INFO - 'SHLVL': '1', 10:37:59 INFO - 'TERM': 'linux', 10:37:59 INFO - 'TMOUT': '86400', 10:37:59 INFO - 'USER': 'cltbld', 10:37:59 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1476466203.857261-1810195576', 10:37:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:37:59 INFO - '_': '/tools/buildbot/bin/python'} 10:37:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:37:59 INFO - Running setup.py (path:/tmp/pip-la04FM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:37:59 INFO - Running setup.py (path:/tmp/pip-eZgOJb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:38:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:38:00 INFO - Running setup.py (path:/tmp/pip-JBZtGt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:38:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:38:00 INFO - Running setup.py (path:/tmp/pip-ALHowE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:38:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:38:00 INFO - Running setup.py (path:/tmp/pip-_nXM5M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:38:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:38:00 INFO - Running setup.py (path:/tmp/pip-MPthSG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:38:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:38:00 INFO - Running setup.py (path:/tmp/pip-DlU88x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:38:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:38:00 INFO - Running setup.py (path:/tmp/pip-V72EhD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:38:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:38:00 INFO - Running setup.py (path:/tmp/pip-o9qoW9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:38:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:38:00 INFO - Running setup.py (path:/tmp/pip-vri3V_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:38:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:38:00 INFO - Running setup.py (path:/tmp/pip-ou6Crx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:38:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:38:00 INFO - Running setup.py (path:/tmp/pip-BGwEnK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:38:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:38:00 INFO - Running setup.py (path:/tmp/pip-TN8Ts0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:38:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:38:00 INFO - Running setup.py (path:/tmp/pip-HD4kPM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:38:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:38:00 INFO - Running setup.py (path:/tmp/pip-UpySoA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:38:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:38:01 INFO - Running setup.py (path:/tmp/pip-rjrUbt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:38:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:38:01 INFO - Running setup.py (path:/tmp/pip-uRlY4E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:38:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:38:01 INFO - Running setup.py install for manifestparser 10:38:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:38:01 INFO - Running setup.py install for mozcrash 10:38:01 INFO - Running setup.py install for mozdebug 10:38:01 INFO - Running setup.py install for mozdevice 10:38:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:38:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:38:01 INFO - Running setup.py install for mozfile 10:38:01 INFO - Running setup.py install for mozhttpd 10:38:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:38:01 INFO - Running setup.py install for mozinfo 10:38:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:38:01 INFO - Running setup.py install for mozInstall 10:38:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:38:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:38:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:38:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:38:01 INFO - Running setup.py install for mozleak 10:38:02 INFO - Running setup.py install for mozlog 10:38:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:38:02 INFO - Running setup.py install for moznetwork 10:38:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:38:02 INFO - Running setup.py install for mozprocess 10:38:02 INFO - Running setup.py install for mozprofile 10:38:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:38:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:38:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:38:02 INFO - Running setup.py install for mozrunner 10:38:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:38:02 INFO - Running setup.py install for mozscreenshot 10:38:02 INFO - Running setup.py install for moztest 10:38:02 INFO - Running setup.py install for mozversion 10:38:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:38:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:38:02 INFO - Cleaning up... 10:38:02 INFO - Return code: 0 10:38:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:38: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')]} 10:38:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:38:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:38: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')]} 10:38:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:38:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:38:02 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 0x24a0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26cf400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x275e570>, '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 0x275f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x275f900>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1476466203.857261-1810195576', '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 10:38:02 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 10:38:02 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 10:38:02 INFO - Using env: {'DISPLAY': ':0', 10:38:02 INFO - 'HOME': '/home/cltbld', 10:38:02 INFO - 'LANG': 'en_US.UTF-8', 10:38:02 INFO - 'LANGUAGE': 'en_US:en', 10:38:02 INFO - 'LOGNAME': 'cltbld', 10:38:02 INFO - 'MAIL': '/var/mail/cltbld', 10:38:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:38:02 INFO - 'MOZ_NO_REMOTE': '1', 10:38:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:38:02 INFO - 'NO_EM_RESTART': '1', 10:38:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:38:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:38:02 INFO - 'PWD': '/builds/slave/test', 10:38:02 INFO - 'SHELL': '/bin/bash', 10:38:02 INFO - 'SHLVL': '1', 10:38:02 INFO - 'TERM': 'linux', 10:38:02 INFO - 'TMOUT': '86400', 10:38:02 INFO - 'USER': 'cltbld', 10:38:02 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1476466203.857261-1810195576', 10:38:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:38:02 INFO - '_': '/tools/buildbot/bin/python'} 10:38:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:38:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:38:03 INFO - Running setup.py (path:/tmp/pip-d8sCeD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:38:03 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)) 10:38:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:38:03 INFO - Running setup.py (path:/tmp/pip-CeiKAz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:38:03 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)) 10:38:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:38:03 INFO - Running setup.py (path:/tmp/pip-IP5c2Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:38:03 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)) 10:38:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:38:03 INFO - Running setup.py (path:/tmp/pip-DHebFp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:38:03 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)) 10:38:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:38:03 INFO - Running setup.py (path:/tmp/pip-ESdJk9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:38:03 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)) 10:38:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:38:03 INFO - Running setup.py (path:/tmp/pip-uNJ8nB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:38:03 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)) 10:38:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:38:03 INFO - Running setup.py (path:/tmp/pip-EKfYMY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:38:03 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)) 10:38:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:38:03 INFO - Running setup.py (path:/tmp/pip-3aCbOc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:38:03 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)) 10:38:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:38:03 INFO - Running setup.py (path:/tmp/pip-VyuI0G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:38:03 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)) 10:38:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:38:03 INFO - Running setup.py (path:/tmp/pip-1ZBqBY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:38:03 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)) 10:38:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:38:03 INFO - Running setup.py (path:/tmp/pip-Qu2h8N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:38:03 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)) 10:38:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:38:03 INFO - Running setup.py (path:/tmp/pip-62FQwI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:38:04 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)) 10:38:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:38:04 INFO - Running setup.py (path:/tmp/pip-jQamMj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:38:04 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)) 10:38:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:38:04 INFO - Running setup.py (path:/tmp/pip-DUJ8HC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:38:04 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)) 10:38:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:38:04 INFO - Running setup.py (path:/tmp/pip-NMMIAd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:38:04 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)) 10:38:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:38:04 INFO - Running setup.py (path:/tmp/pip-pjAYF1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:38:04 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)) 10:38:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:38:04 INFO - Running setup.py (path:/tmp/pip-Jv4lPF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:38:04 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)) 10:38:04 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)) 10:38:04 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)) 10:38:04 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)) 10:38:04 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)) 10:38:04 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)) 10:38:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:38:04 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 10:38:04 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 10:38:04 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 10:38:04 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 10:38:04 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 10:38:04 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 10:38:06 INFO - Downloading blessings-1.6.tar.gz 10:38:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:38:06 INFO - Installing collected packages: blessings 10:38:06 INFO - Running setup.py install for blessings 10:38:06 INFO - Successfully installed blessings 10:38:06 INFO - Cleaning up... 10:38:06 INFO - Return code: 0 10:38:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:38:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:38:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:38:06 INFO - Reading from file tmpfile_stdout 10:38:06 INFO - Current package versions: 10:38:06 INFO - argparse == 1.2.1 10:38:06 INFO - blessings == 1.6 10:38:06 INFO - blobuploader == 1.2.4 10:38:06 INFO - docopt == 0.6.1 10:38:06 INFO - functools32 == 3.2.3-2 10:38:06 INFO - jsonschema == 2.5.1 10:38:06 INFO - manifestparser == 1.1 10:38:06 INFO - mozInstall == 1.12 10:38:06 INFO - mozcrash == 0.17 10:38:06 INFO - mozdebug == 0.1 10:38:06 INFO - mozdevice == 0.48 10:38:06 INFO - mozfile == 1.2 10:38:06 INFO - mozhttpd == 0.7 10:38:06 INFO - mozinfo == 0.9 10:38:06 INFO - mozleak == 0.1 10:38:06 INFO - mozlog == 3.3 10:38:06 INFO - moznetwork == 0.27 10:38:06 INFO - mozprocess == 0.23 10:38:06 INFO - mozprofile == 0.28 10:38:06 INFO - mozrunner == 6.12 10:38:06 INFO - mozscreenshot == 0.1 10:38:06 INFO - mozsystemmonitor == 0.3 10:38:06 INFO - moztest == 0.7 10:38:06 INFO - mozversion == 1.4 10:38:06 INFO - psutil == 3.1.1 10:38:06 INFO - requests == 1.2.3 10:38:06 INFO - wsgiref == 0.1.2 10:38:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:38:06 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')]} 10:38:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:38:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:38:06 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')]} 10:38:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:38:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:38:06 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 0x24a0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26cf400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x275e570>, '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 0x275f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x275f900>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1476466203.857261-1810195576', '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 10:38:06 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 10:38:06 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 10:38:06 INFO - Using env: {'DISPLAY': ':0', 10:38:06 INFO - 'HOME': '/home/cltbld', 10:38:06 INFO - 'LANG': 'en_US.UTF-8', 10:38:06 INFO - 'LANGUAGE': 'en_US:en', 10:38:06 INFO - 'LOGNAME': 'cltbld', 10:38:06 INFO - 'MAIL': '/var/mail/cltbld', 10:38:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:38:06 INFO - 'MOZ_NO_REMOTE': '1', 10:38:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:38:06 INFO - 'NO_EM_RESTART': '1', 10:38:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:38:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:38:06 INFO - 'PWD': '/builds/slave/test', 10:38:06 INFO - 'SHELL': '/bin/bash', 10:38:06 INFO - 'SHLVL': '1', 10:38:06 INFO - 'TERM': 'linux', 10:38:06 INFO - 'TMOUT': '86400', 10:38:06 INFO - 'USER': 'cltbld', 10:38:06 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1476466203.857261-1810195576', 10:38:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:38:06 INFO - '_': '/tools/buildbot/bin/python'} 10:38:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:38:07 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)) 10:38:07 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)) 10:38:07 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)) 10:38:07 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)) 10:38:07 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)) 10:38:07 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)) 10:38:07 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)) 10:38:07 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)) 10:38:07 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)) 10:38:07 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)) 10:38:07 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)) 10:38:07 INFO - Cleaning up... 10:38:07 INFO - Return code: 0 10:38:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:38:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:38:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:38:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:38:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:38:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:38:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:38:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24a0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26cf400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x275e570>, '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 0x275f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x275f900>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1476466203.857261-1810195576', '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 10:38:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:38:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:38:07 INFO - Using env: {'DISPLAY': ':0', 10:38:07 INFO - 'HOME': '/home/cltbld', 10:38:07 INFO - 'LANG': 'en_US.UTF-8', 10:38:07 INFO - 'LANGUAGE': 'en_US:en', 10:38:07 INFO - 'LOGNAME': 'cltbld', 10:38:07 INFO - 'MAIL': '/var/mail/cltbld', 10:38:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:38:07 INFO - 'MOZ_NO_REMOTE': '1', 10:38:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:38:07 INFO - 'NO_EM_RESTART': '1', 10:38:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:38:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:38:07 INFO - 'PWD': '/builds/slave/test', 10:38:07 INFO - 'SHELL': '/bin/bash', 10:38:07 INFO - 'SHLVL': '1', 10:38:07 INFO - 'TERM': 'linux', 10:38:07 INFO - 'TMOUT': '86400', 10:38:07 INFO - 'USER': 'cltbld', 10:38:07 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1476466203.857261-1810195576', 10:38:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:38:07 INFO - '_': '/tools/buildbot/bin/python'} 10:38:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:38:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:38:07 INFO - Cleaning up... 10:38:07 INFO - Return code: 0 10:38:07 INFO - Running post-action listener: _resource_record_post_action 10:38:07 INFO - Running post-action listener: _start_resource_monitoring 10:38:07 INFO - Starting resource monitoring. 10:38:07 INFO - [mozharness: 2016-10-14 17:38:07.280509Z] Finished create-virtualenv step (success) 10:38:07 INFO - [mozharness: 2016-10-14 17:38:07.280937Z] Running install step. 10:38:07 INFO - Running pre-action listener: _resource_record_pre_action 10:38:07 INFO - Running main action method: install 10:38:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:38:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:38:07 INFO - Reading from file tmpfile_stdout 10:38:07 INFO - Detecting whether we're running mozinstall >=1.0... 10:38:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:38:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:38:07 INFO - Reading from file tmpfile_stdout 10:38:07 INFO - Output received: 10:38:07 INFO - Usage: mozinstall [options] installer 10:38:07 INFO - Options: 10:38:07 INFO - -h, --help show this help message and exit 10:38:07 INFO - -d DEST, --destination=DEST 10:38:07 INFO - Directory to install application into. [default: 10:38:07 INFO - "/builds/slave/test"] 10:38:07 INFO - --app=APP Application being installed. [default: firefox] 10:38:07 INFO - mkdir: /builds/slave/test/build/application 10:38:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:38:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 10:38:21 INFO - Reading from file tmpfile_stdout 10:38:21 INFO - Output received: 10:38:21 INFO - /builds/slave/test/build/application/firefox/firefox 10:38:21 INFO - Running post-action listener: _resource_record_post_action 10:38:21 INFO - [mozharness: 2016-10-14 17:38:21.069500Z] Finished install step (success) 10:38:21 INFO - [mozharness: 2016-10-14 17:38:21.069782Z] Running run-tests step. 10:38:21 INFO - Running pre-action listener: _resource_record_pre_action 10:38:21 INFO - Running main action method: run_tests 10:38:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:38:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:38:21 INFO - Python 2.7.3 10:38:21 INFO - Return code: 0 10:38:21 INFO - grabbing minidump binary from tooltool 10:38:21 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')]} 10:38:21 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 0x275e570>, '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 0x275f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x275f900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:38:21 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 10:38:21 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 10:38:21 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 10:38:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:38:21 INFO - Return code: 0 10:38:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:38:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:38:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:38:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:38:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:38:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/G4cSmpsWT4Ofd0HELKBbuQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--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 10:38:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/G4cSmpsWT4Ofd0HELKBbuQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-037 --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 10:38:21 INFO - Using env: {'DISPLAY': ':0', 10:38:21 INFO - 'HOME': '/home/cltbld', 10:38:21 INFO - 'LANG': 'en_US.UTF-8', 10:38:21 INFO - 'LANGUAGE': 'en_US:en', 10:38:21 INFO - 'LOGNAME': 'cltbld', 10:38:21 INFO - 'MAIL': '/var/mail/cltbld', 10:38:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:38:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:38:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:38:21 INFO - 'MOZ_NO_REMOTE': '1', 10:38:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:38:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:38:21 INFO - 'NO_EM_RESTART': '1', 10:38:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:38:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:38:21 INFO - 'PWD': '/builds/slave/test', 10:38:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:38:21 INFO - 'SHELL': '/bin/bash', 10:38:21 INFO - 'SHLVL': '1', 10:38:21 INFO - 'TERM': 'linux', 10:38:21 INFO - 'TMOUT': '86400', 10:38:21 INFO - 'USER': 'cltbld', 10:38:21 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1476466203.857261-1810195576', 10:38:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:38:21 INFO - '_': '/tools/buildbot/bin/python'} 10:38:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/G4cSmpsWT4Ofd0HELKBbuQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--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 10:38:21 INFO - mozversion application_buildid: 20161014072435 10:38:21 INFO - mozversion application_changeset: 6d65311378a748b84f98ede85d2c541addd8f266 10:38:21 INFO - mozversion application_display_name: Firefox 10:38:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:38:21 INFO - mozversion application_name: Firefox 10:38:21 INFO - mozversion application_remotingname: firefox 10:38:21 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 10:38:21 INFO - mozversion application_vendor: Mozilla 10:38:21 INFO - mozversion application_version: 50.0 10:38:21 INFO - mozversion platform_buildid: 20161014072435 10:38:21 INFO - mozversion platform_changeset: 6d65311378a748b84f98ede85d2c541addd8f266 10:38:21 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 10:38:21 INFO - mozversion platform_version: 50.0 10:38:21 INFO - using testdate: 1476466701 10:38:21 INFO - actual date: 1476466701 10:38:21 INFO - starting webserver on 'localhost:52377' 10:38:21 INFO - SUITE-START | Running 2 tests 10:38:21 INFO - TEST-START | dromaeo_css 10:38:21 INFO - operating with platform_type : linux_ 10:38:21 INFO - Initialising browser for dromaeo_css test... 10:38:21 INFO - TEST-INFO | started process 25572 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjdjNcS/profile http://localhost:52377/getInfo.html) 10:38:25 INFO - PROCESS | 25572 | __metrics Screen width/height:1600/1200 10:38:25 INFO - PROCESS | 25572 | colorDepth:24 10:38:25 INFO - PROCESS | 25572 | Browser inner width/height: 1024/697 10:38:25 INFO - PROCESS | 25572 | __metrics 10:38:26 ERROR - PROCESS | 25572 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 10:38:26 INFO - TEST-INFO | 25572: exit 0 10:38:26 INFO - Browser initialized. 10:38:26 INFO - Running cycle 1/1 for dromaeo_css test... 10:38:26 INFO - TEST-INFO | started process 25696 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjdjNcS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:38:38 INFO - PROCESS | 25696 | RSS: Main: 149762048 10:38:38 INFO - PROCESS | 25696 | 10:39:28 INFO - PROCESS | 25696 | 1476466768333 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] 10:41:36 INFO - PROCESS | 25696 | Cycle 1(1): loaded http://localhost:52377/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52377/tests/dromaeo/cssquery-ext.html) 10:41:37 INFO - PROCESS | 25696 | RSS: Main: 158404608 10:41:37 INFO - PROCESS | 25696 | 10:44:39 INFO - PROCESS | 25696 | Cycle 1(1): loaded http://localhost:52377/tests/dromaeo/cssquery-ext.html (next: http://localhost:52377/tests/dromaeo/cssquery-jquery.html) 10:44:40 INFO - PROCESS | 25696 | RSS: Main: 155840512 10:44:40 INFO - PROCESS | 25696 | 10:47:42 INFO - PROCESS | 25696 | Cycle 1(1): loaded http://localhost:52377/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52377/tests/dromaeo/cssquery-mootools.html) 10:47:42 INFO - PROCESS | 25696 | RSS: Main: 155201536 10:47:42 INFO - PROCESS | 25696 | 10:50:44 INFO - PROCESS | 25696 | Cycle 1(1): loaded http://localhost:52377/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52377/tests/dromaeo/cssquery-prototype.html) 10:50:45 INFO - PROCESS | 25696 | RSS: Main: 156749824 10:50:45 INFO - PROCESS | 25696 | 10:53:47 INFO - PROCESS | 25696 | Cycle 1(1): loaded http://localhost:52377/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52377/tests/dromaeo/cssquery-yui.html) 10:53:48 INFO - PROCESS | 25696 | RSS: Main: 157630464 10:53:48 INFO - PROCESS | 25696 | 10:56:50 INFO - PROCESS | 25696 | Cycle 1(1): loaded http://localhost:52377/tests/dromaeo/cssquery-yui.html (next: http://localhost:52377/tests/dromaeo/cssquery-dojo.html) 10:56:50 INFO - PROCESS | 25696 | RSS: Main: 157569024 10:56:50 INFO - PROCESS | 25696 | 10:56:50 INFO - PROCESS | 25696 | __start_tp_report 10:56:50 INFO - PROCESS | 25696 | _x_x_mozilla_page_load 10:56:50 INFO - PROCESS | 25696 | _x_x_mozilla_page_load_details 10:56:50 INFO - PROCESS | 25696 | |i|pagename|runs| 10:56:50 INFO - PROCESS | 25696 | |0;dojo.html;3240.6111266648;3273.067175854882;3278.9016329510114;3292.7201187899027;3301.570795796546;5713.257276554047;5772.105323674827;5785.884282314351;5797.072468405056;5798.65208087515;5664.631798933066;5665.631733937302;5741.913871291934;5745.2818397700285;5753.798617048405;5203.661761985478;5215.191645294985;5221.112410890158;5269.156934890419;5290.973545132289;5263.526282634562;5265.3155089838265;5274.077036518613;5287.814926477574;5300.814471493499;5127.154019586764;5129.794808207667;5263.763130659129;5272.8154514592;5285.339332583427;5197.896042079156;5267.28891599633;5269.841904742864;5271.525562699376;5305.124654432014;5188.92216616751;5231.2937753403185;5235;5237.73811309433;5240.633155679104;5559.8888022239325;5634.154876768476;5655.434456554352;5704.372519022904;5783.537317014629;6120.969395152996;6191.969040154815;6192.9380706192815;6196.101565273055;6209.96895015522;6209.782657606962;6241.21984751906;6247.125402443661;6248.250209974786;6252.87494250117;5606.383297837276;5702.600817942704;5800.854978625526;5820.903693307618;5840.474357307863;6201;6305.873882522324;6308.337624549448;6324.9051264231075;6333.778317758856;6046.516278697693;6060.969695151496;6103.176071230327;6118.357572454828;6127.050307202391;5885.205497257901;6022.728977196037;6149.13912052313;6189.876202475925;6190.690465476799;6011.458968692838;6111.677652033329;6117.066276512122;6123.008104567321;6142.877142457215;6100.967129523837;6129.939558357133;6130.662813545208;6140.263168419819;6166.568340216142;4552.931706024412;4596.287575425815;4666.393368862026;4670.976645116821;4685.344051832746;4110.691698122653;4158.625723684883;4161.3549899765585;4199.475065616798;4201.957980420218;5857.209276747584;5876.324222714357;5901.655720100909;5906.645601263938;5946.583739138306;5928.555358348141;6053.606515576562;6173.444390004921;6178.474829639531;6196;5832.329282132524;5886.676232807236;5892.410758924073;5899.321578018497;5926.496247818897;5146.562542183881;5146.922796158061;5149.510796474329;5152.948470515322;5159.17453207485;6130.356312587203;6262.906056409066;6271.247450305992;6387.073874288202;6395;6187.504999600112;6238.469730072995;6238.625682459067;6243.282022567372;6246;6313.936860631518;6348.143000694847;6350.460210881942;6356.809295721136;6363.904541431974;5838.970805145947;5985.581009329305;6018.699065046818;6097.695115244132;6110.51115910735;6227.626342419469;6234.1583886174785;6235.064740288993;6240.968795155995;6246.125542424155;6019.277686677627;6061.212042434631;6073.448435378344;6074.3925607438905;6077.453029227214;5792.275965504312;5943.494802941798;5984.401559843981;6083.330833608388;6115.235595550556;5942.6731529766275;5996.760129594767;5997.13041608973;6005.3694362091355;6018.398160183947;6059.242594675666;6066.848328791815;6078.696065196811;6100.298465676504;6102.420270074336;5760.1935728998815;5800;5888.499477544286;5940.554458415722;5941.702914854326 10:56:50 INFO - PROCESS | 25696 | |1;ext.html;600.9248843894513;642.9196350456192;663.0683889135765;664.2493981800565;719.154992883362;42078.57921420785;46697.299540506916;46704;46737;46806.76596617012;46799;47189.76405117969;47424.762876185574;47469.762651186786;47499.28751068728;9131.132542408477;9242;9254.444733316022;9256.583453744564;9277.768055798591;9134.817303653956;9205.355625106211;9215.907840921573;9248.075192480765;9250.953745231265;9258.814823703522;9268.814623707522;9304.11610896967;9304.395214311047;9305.95347023264;9180.724578262629;9194.862077068849;9209.58556864936;9239.122283383067;9253.35226534143;9171.908280917172;9213.677521286723;9219.216366608845;9247.537623118884;9253.02843201461;36497.63502364969;36719.449208261896;36941;36959.815200924095;37000.81499592512;3789.5263092113487;3873.573906870242;4042.393640953851;4149.647279981175;4677.74272415017;34775.652243477496;35048.12379690503;35336;35887;36423.81788091043;4234.216669916044;4374.365716971021;4449.6662750293535;4465.10697860426;4490.169318676056;354836;355310;357631;358014;358493;68121.65939170272;68192;68710;68765;68783;39281.214375712894;40370.990725232106;40700;42319.57680423218;42335;15861.048337099812;15891.523254302389;15932.123733194785;15938.760918586231;15950.521484355488;13956.581302560737;13977;13998.510052148125;14040.508582199574;14054.508092216927;21089.261875834272;21145.365639030853;21160.788392115883;21282.787172128392;21578.136874525157;7488.251174882468;7552.9244707552225;7760.146383897767;7829.491083079582;7893.250141236574;1034.7206254311293;1086.603389762731;1099.7360633447915;1162.430409099552;1250.9374531273581;34866.47700284498;35289;35338.646613533536;35351.823240883634;36087;1090.9908334790287;1234.4321612058375;1236.9319687417278;1249.5876360800914;1277.4379273119798;17938.730919036225;18605;18736.344227952228;18847.24611015544;18865;567066;570629;570693;572033;574889;66569.33430665729;66922;66942.66528667326;67053;67229.66385168042;1456.089943785113;1457.679310551677;1458.5332693538178;1495.2523738130935;1499.8650121489118;33792.66207337895;34135.82932085423;34194.31611367709;34207.65792342045;34346.65653343435;58421.4157858416;58903.11645325409;59015;59034.40965590289;59041;453911;459317;460422;461825;461904;28606.284842878264;29006.27484312909;29029.419411611227;29167.416651667274;29193;53569.73215133899;54609.907801844536;54630.72684636551;54841.1773823385;55812;46379;47694.52305476901;48055.75972120117;48464;48466.95118246771;47166.52833471621;47784.283235752184;47873.281900772214;48169;48677;45371.319430207914;46354.76822615865;46798.53201468078;47378.05243895034;48391.5160848387;39406.802965984985;40153.79923100366;40372.1925561493;40790.59209407868;41234;30169.69830301669;31156.53265201069;31406.685933140376;31421;31575.368492630478 10:56:50 INFO - PROCESS | 25696 | |2;jquery.html;429.8608686979502;437.23920378541334;439.13052156729674;441.29392971246;449.9067266542301;19432;20358.491037724063;20935.47661308468;21242.25652102177;21261.68107478389;19284.807151928475;19848.801511984875;20753;20889.164433422684;20902.790972090275;5687.687177205242;5928.170056192136;5933.406659334075;5941.079132734411;5942.346341902387;5859.209006784094;5862.853428664296;5868.061110222366;5888.5877988540815;5894.233749612545;5810.418958104198;5819.185314056035;5836.474717275444;5838.737256823432;5845.415458454163;5686.346070201917;5831.912521312183;5881.82354529367;5900.1739756434135;5968.283805943272;5722.484976352148;5795.884082318372;5822.068469044975;5877.735501902424;5910.67491287979;13872.375743091585;14079.788803167961;14085.15489070659;14171.433142674281;14449.638759031002;2375.988120059406;2410.505846301504;2534.7845433138204;2540.5300019496453;2804.2288370698016;10906.400147991857;12006.879931200663;12323.445444955;14640.341184646717;15640.2179891005;1835.843953263974;2031.4007367826528;2067.359118673216;2099.7585277692956;2119.205298013245;83449.58275208584;85261.57369213115;86700;86759.13240867574;86933;10780.353178809297;10818.459077046116;10890.61882834097;11232.438378081226;12082.516699332104;16945.237464314134;16966.575835603962;16978.23597938096;16984.91507542479;16992.405265815636;7535.058117735283;7845.960770196112;7892.84214315722;8014.759557213293;8594.914050859412;7375.8156046099275;7550.093988721389;7552.735654252075;7580;7789.104253010976;4936.136176169156;5000.499950004971;5017.523335283142;5135.6918584885025;5198.974005130026;2137.070374387147;2138.5295235048266;2178.8256939445123;2198.703175071345;2218.057325636598;467.11015515443137;468.833564084745;487.9316895634614;1029.2177944762034;1094.8467214589964;11529.423528823525;12513.874861251454;12708.5650723025;12756.681082973;12776.808347874789;421.29012613745937;426.79727129613184;466.74562363511967;470.58353357279054;506.69851438394096;6823.658817059128;7048.612326322102;7058.54119482232;7075.858482830417;7187;485394;493858;494806;534951.3009739784;559420;64245.678771605846;72258.63870680613;97560;98227.50886245523;101791;501.1605560685837;509.6687153350352;510.1276816643507;510.8595136337537;510.9948900510947;11592.478338474957;11812;11886.108541859569;12047.698807529881;12110.333931633493;41447.37828932629;42062;42885.57114428816;43638.56361436345;43963.12073758571;60422;62895.6855215721;63797.68101159464;64686.353136469916;65085.02372464322;8778.734556345938;8857.601407936787;8896.733098007071;9059.63761449561;9116.1339672731;10269.383836969806;12992.675183120498;13260.469581217028;13497.932510337778;13656.385462654403;12323.50705971787;12387.504499820267;12498.25010499373;12523.624291271277;12683.682907927006;12183.086268529718;12221.388930553614;12238.510459581874;12238.816417753562;12468.750624987631;12330;12461.1900226485;12518.749625007631;12609.810852837398;12757.425915833996;8660.653573856975;8675.219230269306;8950.507722075088;9029.142231487998;9264.212541934012;11974.58088966882;12206.877931220573;12213.572524961584;12330.136890417585;12330.136890417585 10:56:50 INFO - PROCESS | 25696 | |3;mootools.html;1547.4815936661214;1557.3069983857185;1758.323045627433;1799.6580649676569;1865.5709186887016;9175.265978721704;9322.067793220684;9397.1072748089;10149.898501014988;10158.1873450124;9846.753831154225;9978.35140715853;10040.447775372351;10044.648437304677;10103.595856165763;2479.9132030378987;2504.9749502505015;2517.244826552036;2520.407704189514;2522.672052633164;2418.093215044358;2423.1882319423016;2423.466837295801;2426.9878650606724;2430.732619411863;2437.8049756019564;2441.170002199252;2476.554220240356;2487.6019836826113;2502.2618327593405;2107.631164546206;2117.1848838197407;2121.342383861;2124.72378590783;2135.95728085439;2332.8250381221305;2343.7890589846997;2346.988265058681;2348.8825558721996;2353.2469609724894;9973.451460169688;10033.498325083716;10080.64717734883;10092.293539452241;10103.898961010369;5579.832605021856;5714.914276285859;5721;5725.685087320196;5738.167965645;3581.086822860154;3605;3624.9456258156147;3669.4495825626104;3673.7061035117395;1258.9496420143275;1265.5823578219258;1272.0713878868385;1302.5766625846638;1325.5890673891124;13199.472021119143;13241.668958276121;13269.86730132696;13272.203667779964;13335.333233338295;4301.698881078357;4462.6876118672035;4604.769761511911;4638.2115040443205;4653.744044077541;10385.740356491147;10443.738906527398;10446.68659940203;10513.106385957126;10518.579256829642;5451.918221226685;5484.91772623411;5489.972550137224;5511.22842802008;5511.862203444865;4692.671512994126;5060.911903940597;5130.538251557377;5137.460566640449;5189.584833213334;4030.717849750489;4104.91790164195;4138.896527586834;4150.232207041707;4179.895502612459;1161.5469966712988;1168.7662467506532;1172.7595842852195;1179.0920990837008;1196.6649338185323;920.9079092090738;986.1124987511297;1003.6938733686296;1017.1557607186018;1021.8671572695501;6123.050927106306;6226.688665566703;6353.396427339396;6372;6507.7071531781185;454.6226631895519;457.37339844413367;463.03688328277104;464.81639752297656;473.8815296175956;4244.129953359554;4283.357496375568;4314.633256173198;4341.5007274163245;4344.413504176959;12056.095792815573;12512.436940337706;12590.748185036431;12639.05207109452;12640.304783236827;11429.885701142883;12447.253164810141;12509.687257818445;12527.185732927514;12557.623271301876;8785.560721963877;9248.861267081;9264.768380790534;9271.397359171633;9288.164065234027;6294.874102518015;6353.14232578596;6363;6467.126937863328;6529.640869752209;11313;11375.601853935073;11440.313581185155;11504.079673626256;11574.71063223426;11398.373089480157;11592.768144636892;11681.240719353214;11851.288922664668;11933.164678472423;7598.886016709865;8395.160483951557;8639.568021599021;8716.60775265102;8819.559022049;9574.712758617252;9617.951910240685;9640.469774162488;9641.37331073478;9659.372140810825;8259.504429733995;8322.417430779788;8343.707970221014;8414.24271815515;8560.14398560139;8560.529170895661;8608.741737747878;8646.870296945677;8648.78378040554;8672.089430609947;7958.641861116148;7968.282854543119;8043.879341809995;8047.356211503183;8058.435909486279;5261.552768014762;5292.9735351323;5424.538914192338;5452.0731475648445;5492.697901615449;5552.389237183826;5566.387697353369;5570.498655121059;5623.971880140573;5657.5473962082115 10:56:50 INFO - PROCESS | 25696 | |4;prototype.html;343.883079752884;344.6605093982428;347.782635852592;350.13516613963515;351.10643412515145;5741.885162296751;5745.2476994516655;5782.161586569945;5796.217510636063;5812.157237200603;5653.802116925908;5656.91514627281;5733.827985160441;5736.397678243777;5737.827865164041;4241.830326786925;4330.393744875704;4456.643468522527;4496.9207390226275;4498.67098347224;4497.910041799162;4498.775061246941;4515.774211289438;4515.796789144496;4519.299508576176;4457.710248833815;4473.932891006638;4476.664250181233;4480.977595112036;4485.9551404485865;4315.482142142947;4434.379186913835;4468.687191896569;4480.395146655193;4488.304312831517;3957.7823219722904;3972.483577134983;3973.7615743055508;3975.363941769303;3993.5407428145845;5549.639273447254;5561.4716601922755;5564.081926482126;5569.582281328917;5570.3315602127595;4982.725950072744;5141.562967147797;5166.61250406221;5172.379314482248;5182.740862956837;5985.670788106652;5986.191864098335;5993.7712768882275;5994.730237139339;6003.309619393782;4289.1421715657;4366.820958341262;4388.078503514266;4396.604305612478;4400.11997600478;6186.823893871664;6213.751449941997;6214;6221.751129954796;6255.280642726099;4489.528599497071;4489.663275254369;4503.324501324828;4522.932156017662;4524.457065152203;4123.072308730571;4523.705959112713;4532.546745325507;4538;4566.13243483737;5008.273800298936;5029.270755740397;5036.143855544493;5048.7728052237735;5052.747362631853;6019.307779605314;6049.820285044374;6052.848678783065;6057.666828324396;6086.3000754913755;1454.70178613384;1508.2835653064706;1509.3736099518796;1520.186700115455;1527.114273721239;972.8929817720045;976.6630512473185;1007.3351587952063;1023.9692809215735;1035.2142554094128;5817.563682723812;5836.358000619928;5905.498032667271;5932.5550583705535;5935.347111817697;6118.265808103056;6200.968995154995;6205.5345849061505;6212.54005308752;6213.782517611862;5695.515881150149;5758.193852860602;5836.182934389189;5850.444207800252;5853.570768131178;3259.7881137726445;3295.950560741591;3317.9004629861142;3318.5354050432957;3318.6681331867103;6135.478484328793;6316.368363163739;6338.936610633927;6364.395382438661;6375.489960803125;6267.9287149296515;6298.527610429236;6300.621962682254;6304.148939893055;6320.209973753281;6140.556969112255;6337.366263373718;6344.397282258178;6354.364563543609;6380;6113.510919126548;6153.2616086068165;6155.322914479314;6176.166217560572;6179.165812615419;6047.274327080779;6079.021279573066;6081.726322315595;6089;6096.8780624388155;6100.511959043355;6315.936840631535;6320.304766475592;6338.366163383625;6340.841478962879;4343.565643435758;4345.913081738411;4346.239772891984;4353.172897149531;4355.237833379083;5916.645001299936;6147.186579958833;6157.261128664589;6157.261128664589;6158.199434073542;5977.6114552553945;5993.940060599338;6020.946334391551;6023.795240951739;6040.939590604038;5979.790707325223;5993.910091348546;5999.800039991932;6014.518838492998;6022.819315420545;5768;5896.380880007538;5899.91150132757;5966.3735307793795;6075.2405949256345;6168.290646575701;6168.691565421621;6173.104899789595;6173.876522469615;6200.224971878515;5807.725117543117;5998.880022399615;6000.609960352563;6002.189704389852;6019.247594050744 10:56:50 INFO - PROCESS | 25696 | |5;yui.html;831.5135645647296;856.9742907712771;880.9999999999999;908.8682141089546;929.5723966975194;16592.004479731226;17795.19921603528;17817.198226079825;17863.642727145467;17884.37404690836;15901.602459938507;15986.12076335801;16396.426125085625;16462.094584797862;17108.572285692862;844.5228445928046;846.4455781463151;871.9302455803552;872.3457406944791;873.9431936924111;869.8956125264978;876.3602570123813;877.2368039805378;878.0736323179044;879.4020066354876;902.3638334973828;909.4815954905706;909.9363044586881;910.0171814440422;912.0651332384293;907.1925985872579;908.9091090890925;909.0909090909091;909.2089881802808;909.3770767024544;672.2605134352174;672.2840175213382;672.8183390484542;673.2426020726682;673.6463356737703;16509.257083431276;16509.83490165095;16599.6680066398;16700.08149551774;16733.497995060166;16146.567143299711;16339.83660163395;16389.754153687703;16394.83605163945;16407.1796410179;12913.741725165539;13259.27074010929;13263.734725305536;13375.53185638498;14085;4135.379693046068;4160.91678166438;4179.1432756284885;4180.7909604519655;4271.2738834397915;81692.59153704194;81755;81970.59014704949;82137;82666;12020.939895300642;12146.817797733042;12246.81629775554;12295.692607684701;12318.445669944875;23126.190583329502;23296.76703232946;23697.7630223699;24146.637800433007;24388.390290242533;9221.677241296522;9394.201492873046;9658.855117173249;9687.854682179774;9728.221742260603;4865.7323847188745;4977.601791856643;4987.700737955734;5185.559227465632;5200.2979597754575;3763.7553559018575;3885.4171874218528;3885.825137868803;3887;3895.2988462076532;615.6603562226952;662.9469642428594;685.9485538584626;688.6419062087687;694.9096617439801;722.1334398721555;732.1360794262821;782.4835608498364;790.9762707118796;831.2186544648011;10321.535530901128;10384.3250188739;10430.582776689;10553.525091370906;10713.196510261605;704.2851505721696;782.9117526637978;829.4649950781712;835.1648351648352;837.3343192162124;5182.922256166161;5264.92102618461;5272.340957380327;5345.278387417648;5346.599005074635;80784;81566;89388.5530572356;137792;143748;117886.41056794662;119541.40229298797;120526;121178.3941080289;126647;100092;106504;109946.45026774815;111021.44489277664;111710;9866.703998880044;10044.899551004688;10330.845037324596;10344.224183186141;10622;46204.76897615625;61749;62691.37308627038;63168.68415658076;63553.364466354746;71232.64383678048;77013;87441.56279218564;87756;92865.5356723212;14112.788308175592;14176.716465670836;14204.28978551089;14264;14362.640933976734;16264.349426022827;16484.34062637529;16529.752053718963;16861.156942153088;16983.235754390837;13880.097793643381;13890.166590004632;13931.651708707363;15339.923300383427;15410.460633877761;14911.552653420415;15027.849721502645;15352.385904563693;15709.371625134867;16121;14936.626584335045;15108.244587770787;15294.694106118039;15527.767083493982;15559.299831507837;12091.637250882488;12319.384030798245;12447.875521245034;12606.180598261084;13034.804477933028;12691.428885699981;12721.618351449471;12815.61553153407;12985;13133.080684352004 10:56:50 INFO - PROCESS | 25696 | __end_tp_report 10:56:50 INFO - PROCESS | 25696 | __start_cc_report 10:56:50 INFO - PROCESS | 25696 | _x_x_mozilla_cycle_collect,352 10:56:50 INFO - PROCESS | 25696 | __end_cc_report 10:56:50 INFO - PROCESS | 25696 | __startTimestamp1476467810665__endTimestamp 10:56:50 INFO - PROCESS | 25696 | 10:56:50 INFO - PROCESS | 25696 | ------- Summary: start ------- 10:56:50 INFO - PROCESS | 25696 | Number of tests: 6 10:56:50 INFO - PROCESS | 25696 | 10:56:50 INFO - PROCESS | 25696 | [#0] dojo.html Cycles:165 Average:5711.58 Median:5941.70 stddev:664.29 (11.2%) stddev-sans-first:637.42 10:56:50 INFO - PROCESS | 25696 | Values: 3240.6 3273.1 3278.9 3292.7 3301.6 5713.3 5772.1 5785.9 5797.1 5798.7 5664.6 5665.6 5741.9 5745.3 5753.8 5203.7 5215.2 5221.1 5269.2 5291.0 5263.5 5265.3 5274.1 5287.8 5300.8 5127.2 5129.8 5263.8 5272.8 5285.3 5197.9 5267.3 5269.8 5271.5 5305.1 5188.9 5231.3 5235.0 5237.7 5240.6 5559.9 5634.2 5655.4 5704.4 5783.5 6121.0 6192.0 6192.9 6196.1 6210.0 6209.8 6241.2 6247.1 6248.3 6252.9 5606.4 5702.6 5800.9 5820.9 5840.5 6201.0 6305.9 6308.3 6324.9 6333.8 6046.5 6061.0 6103.2 6118.4 6127.1 5885.2 6022.7 6149.1 6189.9 6190.7 6011.5 6111.7 6117.1 6123.0 6142.9 6101.0 6129.9 6130.7 6140.3 6166.6 4552.9 4596.3 4666.4 4671.0 4685.3 4110.7 4158.6 4161.4 4199.5 4202.0 5857.2 5876.3 5901.7 5906.6 5946.6 5928.6 6053.6 6173.4 6178.5 6196.0 5832.3 5886.7 5892.4 5899.3 5926.5 5146.6 5146.9 5149.5 5152.9 5159.2 6130.4 6262.9 6271.2 6387.1 6395.0 6187.5 6238.5 6238.6 6243.3 6246.0 6313.9 6348.1 6350.5 6356.8 6363.9 5839.0 5985.6 6018.7 6097.7 6110.5 6227.6 6234.2 6235.1 6241.0 6246.1 6019.3 6061.2 6073.4 6074.4 6077.5 5792.3 5943.5 5984.4 6083.3 6115.2 5942.7 5996.8 5997.1 6005.4 6018.4 6059.2 6066.8 6078.7 6100.3 6102.4 5760.2 5800.0 5888.5 5940.6 5941.7 10:56:50 INFO - PROCESS | 25696 | 10:56:50 INFO - PROCESS | 25696 | [#1] ext.html Cycles:180 Average:63670.05 Median:249641.16 stddev:124772.55 (50.0%) stddev-sans-first:125032.72 10:56:50 INFO - PROCESS | 25696 | Values: 600.9 642.9 663.1 664.2 719.2 42078.6 46697.3 46704.0 46737.0 46806.8 46799.0 47189.8 47424.8 47469.8 47499.3 9131.1 9242.0 9254.4 9256.6 9277.8 9134.8 9205.4 9215.9 9248.1 9251.0 9258.8 9268.8 9304.1 9304.4 9306.0 9180.7 9194.9 9209.6 9239.1 9253.4 9171.9 9213.7 9219.2 9247.5 9253.0 36497.6 36719.4 36941.0 36959.8 37000.8 3789.5 3873.6 4042.4 4149.6 4677.7 34775.7 35048.1 35336.0 35887.0 36423.8 4234.2 4374.4 4449.7 4465.1 4490.2 354836.0 355310.0 357631.0 358014.0 358493.0 68121.7 68192.0 68710.0 68765.0 68783.0 39281.2 40371.0 40700.0 42319.6 42335.0 15861.0 15891.5 15932.1 15938.8 15950.5 13956.6 13977.0 13998.5 14040.5 14054.5 21089.3 21145.4 21160.8 21282.8 21578.1 7488.3 7552.9 7760.1 7829.5 7893.3 1034.7 1086.6 1099.7 1162.4 1250.9 34866.5 35289.0 35338.6 35351.8 36087.0 1091.0 1234.4 1236.9 1249.6 1277.4 17938.7 18605.0 18736.3 18847.2 18865.0 567066.0 570629.0 570693.0 572033.0 574889.0 66569.3 66922.0 66942.7 67053.0 67229.7 1456.1 1457.7 1458.5 1495.3 1499.9 33792.7 34135.8 34194.3 34207.7 34346.7 58421.4 58903.1 59015.0 59034.4 59041.0 453911.0 459317.0 460422.0 461825.0 461904.0 28606.3 29006.3 29029.4 29167.4 29193.0 53569.7 54609.9 54630.7 54841.2 55812.0 46379.0 47694.5 48055.8 48464.0 48467.0 47166.5 47784.3 47873.3 48169.0 48677.0 45371.3 46354.8 46798.5 47378.1 48391.5 39406.8 40153.8 40372.2 40790.6 41234.0 30169.7 31156.5 31406.7 31421.0 31575.4 10:56:50 INFO - PROCESS | 25696 | 10:56:50 INFO - PROCESS | 25696 | [#2] jquery.html Cycles:180 Average:29418.29 Median:438.18 stddev:84855.40 (19365.2%) stddev-sans-first:85065.53 10:56:50 INFO - PROCESS | 25696 | Values: 429.9 437.2 439.1 441.3 449.9 19432.0 20358.5 20935.5 21242.3 21261.7 19284.8 19848.8 20753.0 20889.2 20902.8 5687.7 5928.2 5933.4 5941.1 5942.3 5859.2 5862.9 5868.1 5888.6 5894.2 5810.4 5819.2 5836.5 5838.7 5845.4 5686.3 5831.9 5881.8 5900.2 5968.3 5722.5 5795.9 5822.1 5877.7 5910.7 13872.4 14079.8 14085.2 14171.4 14449.6 2376.0 2410.5 2534.8 2540.5 2804.2 10906.4 12006.9 12323.4 14640.3 15640.2 1835.8 2031.4 2067.4 2099.8 2119.2 83449.6 85261.6 86700.0 86759.1 86933.0 10780.4 10818.5 10890.6 11232.4 12082.5 16945.2 16966.6 16978.2 16984.9 16992.4 7535.1 7846.0 7892.8 8014.8 8594.9 7375.8 7550.1 7552.7 7580.0 7789.1 4936.1 5000.5 5017.5 5135.7 5199.0 2137.1 2138.5 2178.8 2198.7 2218.1 467.1 468.8 487.9 1029.2 1094.8 11529.4 12513.9 12708.6 12756.7 12776.8 421.3 426.8 466.7 470.6 506.7 6823.7 7048.6 7058.5 7075.9 7187.0 485394.0 493858.0 494806.0 534951.3 559420.0 64245.7 72258.6 97560.0 98227.5 101791.0 501.2 509.7 510.1 510.9 511.0 11592.5 11812.0 11886.1 12047.7 12110.3 41447.4 42062.0 42885.6 43638.6 43963.1 60422.0 62895.7 63797.7 64686.4 65085.0 8778.7 8857.6 8896.7 9059.6 9116.1 10269.4 12992.7 13260.5 13497.9 13656.4 12323.5 12387.5 12498.3 12523.6 12683.7 12183.1 12221.4 12238.5 12238.8 12468.8 12330.0 12461.2 12518.7 12609.8 12757.4 8660.7 8675.2 8950.5 9029.1 9264.2 11974.6 12206.9 12213.6 12330.1 12330.1 10:56:50 INFO - PROCESS | 25696 | 10:56:50 INFO - PROCESS | 25696 | [#3] mootools.html Cycles:180 Average:6322.18 Median:4165.06 stddev:3762.39 (90.3%) stddev-sans-first:3755.84 10:56:50 INFO - PROCESS | 25696 | Values: 1547.5 1557.3 1758.3 1799.7 1865.6 9175.3 9322.1 9397.1 10149.9 10158.2 9846.8 9978.4 10040.4 10044.6 10103.6 2479.9 2505.0 2517.2 2520.4 2522.7 2418.1 2423.2 2423.5 2427.0 2430.7 2437.8 2441.2 2476.6 2487.6 2502.3 2107.6 2117.2 2121.3 2124.7 2136.0 2332.8 2343.8 2347.0 2348.9 2353.2 9973.5 10033.5 10080.6 10092.3 10103.9 5579.8 5714.9 5721.0 5725.7 5738.2 3581.1 3605.0 3624.9 3669.4 3673.7 1258.9 1265.6 1272.1 1302.6 1325.6 13199.5 13241.7 13269.9 13272.2 13335.3 4301.7 4462.7 4604.8 4638.2 4653.7 10385.7 10443.7 10446.7 10513.1 10518.6 5451.9 5484.9 5490.0 5511.2 5511.9 4692.7 5060.9 5130.5 5137.5 5189.6 4030.7 4104.9 4138.9 4150.2 4179.9 1161.5 1168.8 1172.8 1179.1 1196.7 920.9 986.1 1003.7 1017.2 1021.9 6123.1 6226.7 6353.4 6372.0 6507.7 454.6 457.4 463.0 464.8 473.9 4244.1 4283.4 4314.6 4341.5 4344.4 12056.1 12512.4 12590.7 12639.1 12640.3 11429.9 12447.3 12509.7 12527.2 12557.6 8785.6 9248.9 9264.8 9271.4 9288.2 6294.9 6353.1 6363.0 6467.1 6529.6 11313.0 11375.6 11440.3 11504.1 11574.7 11398.4 11592.8 11681.2 11851.3 11933.2 7598.9 8395.2 8639.6 8716.6 8819.6 9574.7 9618.0 9640.5 9641.4 9659.4 8259.5 8322.4 8343.7 8414.2 8560.1 8560.5 8608.7 8646.9 8648.8 8672.1 7958.6 7968.3 8043.9 8047.4 8058.4 5261.6 5293.0 5424.5 5452.1 5492.7 5552.4 5566.4 5570.5 5624.0 5657.5 10:56:50 INFO - PROCESS | 25696 | 10:56:50 INFO - PROCESS | 25696 | [#4] prototype.html Cycles:180 Average:5072.25 Median:5809.94 stddev:1492.79 (25.7%) stddev-sans-first:1454.18 10:56:50 INFO - PROCESS | 25696 | Values: 343.9 344.7 347.8 350.1 351.1 5741.9 5745.2 5782.2 5796.2 5812.2 5653.8 5656.9 5733.8 5736.4 5737.8 4241.8 4330.4 4456.6 4496.9 4498.7 4497.9 4498.8 4515.8 4515.8 4519.3 4457.7 4473.9 4476.7 4481.0 4486.0 4315.5 4434.4 4468.7 4480.4 4488.3 3957.8 3972.5 3973.8 3975.4 3993.5 5549.6 5561.5 5564.1 5569.6 5570.3 4982.7 5141.6 5166.6 5172.4 5182.7 5985.7 5986.2 5993.8 5994.7 6003.3 4289.1 4366.8 4388.1 4396.6 4400.1 6186.8 6213.8 6214.0 6221.8 6255.3 4489.5 4489.7 4503.3 4522.9 4524.5 4123.1 4523.7 4532.5 4538.0 4566.1 5008.3 5029.3 5036.1 5048.8 5052.7 6019.3 6049.8 6052.8 6057.7 6086.3 1454.7 1508.3 1509.4 1520.2 1527.1 972.9 976.7 1007.3 1024.0 1035.2 5817.6 5836.4 5905.5 5932.6 5935.3 6118.3 6201.0 6205.5 6212.5 6213.8 5695.5 5758.2 5836.2 5850.4 5853.6 3259.8 3296.0 3317.9 3318.5 3318.7 6135.5 6316.4 6338.9 6364.4 6375.5 6267.9 6298.5 6300.6 6304.1 6320.2 6140.6 6337.4 6344.4 6354.4 6380.0 6113.5 6153.3 6155.3 6176.2 6179.2 6047.3 6079.0 6081.7 6089.0 6096.9 6100.5 6315.9 6320.3 6338.4 6340.8 4343.6 4345.9 4346.2 4353.2 4355.2 5916.6 6147.2 6157.3 6157.3 6158.2 5977.6 5993.9 6020.9 6023.8 6040.9 5979.8 5993.9 5999.8 6014.5 6022.8 5768.0 5896.4 5899.9 5966.4 6075.2 6168.3 6168.7 6173.1 6173.9 6200.2 5807.7 5998.9 6000.6 6002.2 6019.2 10:56:50 INFO - PROCESS | 25696 | 10:56:50 INFO - PROCESS | 25696 | [#5] yui.html Cycles:180 Average:23168.68 Median:14076.07 stddev:33584.33 (238.6%) stddev-sans-first:33636.66 10:56:50 INFO - PROCESS | 25696 | Values: 831.5 857.0 881.0 908.9 929.6 16592.0 17795.2 17817.2 17863.6 17884.4 15901.6 15986.1 16396.4 16462.1 17108.6 844.5 846.4 871.9 872.3 873.9 869.9 876.4 877.2 878.1 879.4 902.4 909.5 909.9 910.0 912.1 907.2 908.9 909.1 909.2 909.4 672.3 672.3 672.8 673.2 673.6 16509.3 16509.8 16599.7 16700.1 16733.5 16146.6 16339.8 16389.8 16394.8 16407.2 12913.7 13259.3 13263.7 13375.5 14085.0 4135.4 4160.9 4179.1 4180.8 4271.3 81692.6 81755.0 81970.6 82137.0 82666.0 12020.9 12146.8 12246.8 12295.7 12318.4 23126.2 23296.8 23697.8 24146.6 24388.4 9221.7 9394.2 9658.9 9687.9 9728.2 4865.7 4977.6 4987.7 5185.6 5200.3 3763.8 3885.4 3885.8 3887.0 3895.3 615.7 662.9 685.9 688.6 694.9 722.1 732.1 782.5 791.0 831.2 10321.5 10384.3 10430.6 10553.5 10713.2 704.3 782.9 829.5 835.2 837.3 5182.9 5264.9 5272.3 5345.3 5346.6 80784.0 81566.0 89388.6 137792.0 143748.0 117886.4 119541.4 120526.0 121178.4 126647.0 100092.0 106504.0 109946.5 111021.4 111710.0 9866.7 10044.9 10330.8 10344.2 10622.0 46204.8 61749.0 62691.4 63168.7 63553.4 71232.6 77013.0 87441.6 87756.0 92865.5 14112.8 14176.7 14204.3 14264.0 14362.6 16264.3 16484.3 16529.8 16861.2 16983.2 13880.1 13890.2 13931.7 15339.9 15410.5 14911.6 15027.8 15352.4 15709.4 16121.0 14936.6 15108.2 15294.7 15527.8 15559.3 12091.6 12319.4 12447.9 12606.2 13034.8 12691.4 12721.6 12815.6 12985.0 13133.1 10:56:50 INFO - PROCESS | 25696 | -------- Summary: end -------- 10:56:50 INFO - PROCESS | 25696 | 10:56:51 INFO - TEST-INFO | 25696: exit 0 10:56:51 INFO - TEST-OK | dromaeo_css | took 1110032ms 10:56:51 INFO - TEST-START | kraken 10:56:51 INFO - operating with platform_type : linux_ 10:56:51 INFO - Initialising browser for kraken test... 10:56:51 INFO - TEST-INFO | started process 25938 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMhrOk2/profile http://localhost:52377/getInfo.html) 10:56:55 INFO - PROCESS | 25938 | __metrics Screen width/height:1600/1200 10:56:55 INFO - PROCESS | 25938 | colorDepth:24 10:56:55 INFO - PROCESS | 25938 | Browser inner width/height: 1024/697 10:56:55 INFO - PROCESS | 25938 | __metrics 10:56:56 ERROR - PROCESS | 25938 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 10:56:57 INFO - TEST-INFO | 25938: exit 0 10:56:57 INFO - Browser initialized. 10:56:57 INFO - Running cycle 1/1 for kraken test... 10:56:57 INFO - TEST-INFO | started process 26067 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMhrOk2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:57:08 INFO - PROCESS | 26067 | RSS: Main: 150097920 10:57:08 INFO - PROCESS | 26067 | 10:57:11 INFO - PROCESS | 26067 | Cycle 1(1): loaded http://localhost:52377/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52377/tests/kraken/driver.html?testName=audio-beat-detection) 10:57:12 INFO - PROCESS | 26067 | RSS: Main: 156524544 10:57:12 INFO - PROCESS | 26067 | 10:57:14 INFO - PROCESS | 26067 | Cycle 1(1): loaded http://localhost:52377/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52377/tests/kraken/driver.html?testName=audio-dft) 10:57:15 INFO - PROCESS | 26067 | RSS: Main: 154963968 10:57:15 INFO - PROCESS | 26067 | 10:57:18 INFO - PROCESS | 26067 | Cycle 1(1): loaded http://localhost:52377/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52377/tests/kraken/driver.html?testName=audio-fft) 10:57:18 INFO - PROCESS | 26067 | RSS: Main: 156467200 10:57:18 INFO - PROCESS | 26067 | 10:57:21 INFO - PROCESS | 26067 | Cycle 1(1): loaded http://localhost:52377/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52377/tests/kraken/driver.html?testName=audio-oscillator) 10:57:21 INFO - PROCESS | 26067 | RSS: Main: 155725824 10:57:21 INFO - PROCESS | 26067 | 10:57:23 INFO - PROCESS | 26067 | Cycle 1(1): loaded http://localhost:52377/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52377/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:57:24 INFO - PROCESS | 26067 | RSS: Main: 155959296 10:57:24 INFO - PROCESS | 26067 | 10:57:27 INFO - PROCESS | 26067 | Cycle 1(1): loaded http://localhost:52377/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52377/tests/kraken/driver.html?testName=imaging-darkroom) 10:57:28 INFO - PROCESS | 26067 | RSS: Main: 155959296 10:57:28 INFO - PROCESS | 26067 | 10:57:31 INFO - PROCESS | 26067 | Cycle 1(1): loaded http://localhost:52377/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52377/tests/kraken/driver.html?testName=imaging-desaturate) 10:57:32 INFO - PROCESS | 26067 | RSS: Main: 156467200 10:57:32 INFO - PROCESS | 26067 | 10:57:34 INFO - PROCESS | 26067 | Cycle 1(1): loaded http://localhost:52377/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52377/tests/kraken/driver.html?testName=json-parse-financial) 10:57:35 INFO - PROCESS | 26067 | RSS: Main: 155799552 10:57:35 INFO - PROCESS | 26067 | 10:57:37 INFO - PROCESS | 26067 | Cycle 1(1): loaded http://localhost:52377/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52377/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:57:37 INFO - PROCESS | 26067 | RSS: Main: 155000832 10:57:37 INFO - PROCESS | 26067 | 10:57:39 INFO - PROCESS | 26067 | Cycle 1(1): loaded http://localhost:52377/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52377/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:57:39 INFO - PROCESS | 26067 | RSS: Main: 155361280 10:57:39 INFO - PROCESS | 26067 | 10:57:41 INFO - PROCESS | 26067 | Cycle 1(1): loaded http://localhost:52377/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52377/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:57:42 INFO - PROCESS | 26067 | RSS: Main: 156524544 10:57:42 INFO - PROCESS | 26067 | 10:57:45 INFO - PROCESS | 26067 | Cycle 1(1): loaded http://localhost:52377/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52377/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:57:45 INFO - PROCESS | 26067 | RSS: Main: 156319744 10:57:45 INFO - PROCESS | 26067 | 10:57:48 INFO - PROCESS | 26067 | Cycle 1(1): loaded http://localhost:52377/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52377/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:57:49 INFO - PROCESS | 26067 | RSS: Main: 157016064 10:57:49 INFO - PROCESS | 26067 | 10:57:50 INFO - PROCESS | 26067 | Cycle 1(1): loaded http://localhost:52377/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52377/tests/kraken/driver.html?testName=ai-astar) 10:57:50 INFO - PROCESS | 26067 | RSS: Main: 158687232 10:57:50 INFO - PROCESS | 26067 | 10:57:50 INFO - PROCESS | 26067 | __start_tp_report 10:57:50 INFO - PROCESS | 26067 | _x_x_mozilla_page_load 10:57:50 INFO - PROCESS | 26067 | _x_x_mozilla_page_load_details 10:57:50 INFO - PROCESS | 26067 | |i|pagename|runs| 10:57:50 INFO - PROCESS | 26067 | |0;ai-astar;102;112;104;111;112;112;109;111;110;112 10:57:50 INFO - PROCESS | 26067 | |1;audio-beat-detection;146;115;139;166;117;142;144;119;176;118 10:57:50 INFO - PROCESS | 26067 | |2;audio-dft;163;162;162;161;160;161;161;161;161;164 10:57:50 INFO - PROCESS | 26067 | |3;audio-fft;75;75;74;171;79;75;75;76;185;77 10:57:50 INFO - PROCESS | 26067 | |4;audio-oscillator;83;83;155;84;83;84;148;84;84;140 10:57:50 INFO - PROCESS | 26067 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;117 10:57:50 INFO - PROCESS | 26067 | |6;imaging-darkroom;147;148;148;148;148;148;147;149;148;149 10:57:50 INFO - PROCESS | 26067 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;95 10:57:50 INFO - PROCESS | 26067 | |8;json-parse-financial;50;50;50;50;50;50;50;50;52;51 10:57:50 INFO - PROCESS | 26067 | |9;json-stringify-tinderbox;62;59;59;59;60;59;59;59;59;59 10:57:50 INFO - PROCESS | 26067 | |10;stanford-crypto-aes;75;73;74;72;74;73;73;73;78;74 10:57:50 INFO - PROCESS | 26067 | |11;stanford-crypto-ccm;127;118;120;122;125;129;119;118;153;117 10:57:50 INFO - PROCESS | 26067 | |12;stanford-crypto-pbkdf2;153;152;155;152;152;155;153;152;150;159 10:57:50 INFO - PROCESS | 26067 | |13;stanford-crypto-sha256-iterative;61;61;65;64;63;62;63;60;61;61 10:57:50 INFO - PROCESS | 26067 | __end_tp_report 10:57:50 INFO - PROCESS | 26067 | __start_cc_report 10:57:50 INFO - PROCESS | 26067 | _x_x_mozilla_cycle_collect,890 10:57:50 INFO - PROCESS | 26067 | __end_cc_report 10:57:50 INFO - PROCESS | 26067 | __startTimestamp1476467870956__endTimestamp 10:57:50 INFO - PROCESS | 26067 | 10:57:50 INFO - PROCESS | 26067 | ------- Summary: start ------- 10:57:50 INFO - PROCESS | 26067 | Number of tests: 14 10:57:50 INFO - PROCESS | 26067 | 10:57:50 INFO - PROCESS | 26067 | [#0] ai-astar Cycles:10 Average:109.50 Median:111.50 stddev:3.60 (3.2%) stddev-sans-first:2.60 10:57:50 INFO - PROCESS | 26067 | Values: 102.0 112.0 104.0 111.0 112.0 112.0 109.0 111.0 110.0 112.0 10:57:50 INFO - PROCESS | 26067 | 10:57:50 INFO - PROCESS | 26067 | [#1] audio-beat-detection Cycles:10 Average:138.20 Median:143.00 stddev:21.28 (14.9%) stddev-sans-first:22.38 10:57:50 INFO - PROCESS | 26067 | Values: 146.0 115.0 139.0 166.0 117.0 142.0 144.0 119.0 176.0 118.0 10:57:50 INFO - PROCESS | 26067 | 10:57:50 INFO - PROCESS | 26067 | [#2] audio-dft Cycles:10 Average:161.60 Median:161.50 stddev:1.17 (0.7%) stddev-sans-first:1.13 10:57:50 INFO - PROCESS | 26067 | Values: 163.0 162.0 162.0 161.0 160.0 161.0 161.0 161.0 161.0 164.0 10:57:50 INFO - PROCESS | 26067 | 10:57:50 INFO - PROCESS | 26067 | [#3] audio-fft Cycles:10 Average:96.20 Median:75.00 stddev:43.26 (57.7%) stddev-sans-first:45.20 10:57:50 INFO - PROCESS | 26067 | Values: 75.0 75.0 74.0 171.0 79.0 75.0 75.0 76.0 185.0 77.0 10:57:50 INFO - PROCESS | 26067 | 10:57:50 INFO - PROCESS | 26067 | [#4] audio-oscillator Cycles:10 Average:102.80 Median:83.50 stddev:31.17 (37.3%) stddev-sans-first:32.22 10:57:50 INFO - PROCESS | 26067 | Values: 83.0 83.0 155.0 84.0 83.0 84.0 148.0 84.0 84.0 140.0 10:57:50 INFO - PROCESS | 26067 | 10:57:50 INFO - PROCESS | 26067 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 10:57:50 INFO - PROCESS | 26067 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 10:57:50 INFO - PROCESS | 26067 | 10:57:50 INFO - PROCESS | 26067 | [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.00 stddev:0.67 (0.5%) stddev-sans-first:0.60 10:57:50 INFO - PROCESS | 26067 | Values: 147.0 148.0 148.0 148.0 148.0 148.0 147.0 149.0 148.0 149.0 10:57:50 INFO - PROCESS | 26067 | 10:57:50 INFO - PROCESS | 26067 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 10:57:50 INFO - PROCESS | 26067 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 10:57:50 INFO - PROCESS | 26067 | 10:57:50 INFO - PROCESS | 26067 | [#8] json-parse-financial Cycles:10 Average:50.30 Median:50.00 stddev:0.67 (1.3%) stddev-sans-first:0.71 10:57:50 INFO - PROCESS | 26067 | Values: 50.0 50.0 50.0 50.0 50.0 50.0 50.0 50.0 52.0 51.0 10:57:50 INFO - PROCESS | 26067 | 10:57:50 INFO - PROCESS | 26067 | [#9] json-stringify-tinderbox Cycles:10 Average:59.40 Median:59.00 stddev:0.97 (1.6%) stddev-sans-first:0.33 10:57:50 INFO - PROCESS | 26067 | Values: 62.0 59.0 59.0 59.0 60.0 59.0 59.0 59.0 59.0 59.0 10:57:50 INFO - PROCESS | 26067 | 10:57:50 INFO - PROCESS | 26067 | [#10] stanford-crypto-aes Cycles:10 Average:73.90 Median:74.00 stddev:1.66 (2.2%) stddev-sans-first:1.72 10:57:50 INFO - PROCESS | 26067 | Values: 75.0 73.0 74.0 72.0 74.0 73.0 73.0 73.0 78.0 74.0 10:57:50 INFO - PROCESS | 26067 | 10:57:50 INFO - PROCESS | 26067 | [#11] stanford-crypto-ccm Cycles:10 Average:124.80 Median:123.50 stddev:10.73 (8.7%) stddev-sans-first:11.35 10:57:50 INFO - PROCESS | 26067 | Values: 127.0 118.0 120.0 122.0 125.0 129.0 119.0 118.0 153.0 117.0 10:57:50 INFO - PROCESS | 26067 | 10:57:50 INFO - PROCESS | 26067 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.30 Median:153.00 stddev:2.50 (1.6%) stddev-sans-first:2.65 10:57:50 INFO - PROCESS | 26067 | Values: 153.0 152.0 155.0 152.0 152.0 155.0 153.0 152.0 150.0 159.0 10:57:50 INFO - PROCESS | 26067 | 10:57:50 INFO - PROCESS | 26067 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.10 Median:62.50 stddev:1.60 (2.6%) stddev-sans-first:1.64 10:57:50 INFO - PROCESS | 26067 | Values: 61.0 61.0 65.0 64.0 63.0 62.0 63.0 60.0 61.0 61.0 10:57:50 INFO - PROCESS | 26067 | -------- Summary: end -------- 10:57:50 INFO - PROCESS | 26067 | 10:57:51 INFO - TEST-INFO | 26067: exit 0 10:57:51 INFO - TEST-OK | kraken | took 60512ms 10:57:51 INFO - SUITE-END | took 1170s 10:57:52 INFO - Completed test suite (00:19:30) 10:57:52 INFO - javascript benchmark 10:57:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7630.29343384692, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3240.6111266648, 3273.067175854882, 3278.9016329510114, 3292.7201187899027, 3301.570795796546, 5713.257276554047, 5772.105323674827, 5785.884282314351, 5797.072468405056, 5798.65208087515, 5664.631798933066, 5665.631733937302, 5741.913871291934, 5745.2818397700285, 5753.798617048405, 5203.661761985478, 5215.191645294985, 5221.112410890158, 5269.156934890419, 5290.973545132289, 5263.526282634562, 5265.3155089838265, 5274.077036518613, 5287.814926477574, 5300.814471493499, 5127.154019586764, 5129.794808207667, 5263.763130659129, 5272.8154514592, 5285.339332583427, 5197.896042079156, 5267.28891599633, 5269.841904742864, 5271.525562699376, 5305.124654432014, 5188.92216616751, 5231.2937753403185, 5235.0, 5237.73811309433, 5240.633155679104, 5559.8888022239325, 5634.154876768476, 5655.434456554352, 5704.372519022904, 5783.537317014629, 6120.969395152996, 6191.969040154815, 6192.9380706192815, 6196.101565273055, 6209.96895015522, 6209.782657606962, 6241.21984751906, 6247.125402443661, 6248.250209974786, 6252.87494250117, 5606.383297837276, 5702.600817942704, 5800.854978625526, 5820.903693307618, 5840.474357307863, 6201.0, 6305.873882522324, 6308.337624549448, 6324.9051264231075, 6333.778317758856, 6046.516278697693, 6060.969695151496, 6103.176071230327, 6118.357572454828, 6127.050307202391, 5885.205497257901, 6022.728977196037, 6149.13912052313, 6189.876202475925, 6190.690465476799, 6011.458968692838, 6111.677652033329, 6117.066276512122, 6123.008104567321, 6142.877142457215, 6100.967129523837, 6129.939558357133, 6130.662813545208, 6140.263168419819, 6166.568340216142, 4552.931706024412, 4596.287575425815, 4666.393368862026, 4670.976645116821, 4685.344051832746, 4110.691698122653, 4158.625723684883, 4161.3549899765585, 4199.475065616798, 4201.957980420218, 5857.209276747584, 5876.324222714357, 5901.655720100909, 5906.645601263938, 5946.583739138306, 5928.555358348141, 6053.606515576562, 6173.444390004921, 6178.474829639531, 6196.0, 5832.329282132524, 5886.676232807236, 5892.410758924073, 5899.321578018497, 5926.496247818897, 5146.562542183881, 5146.922796158061, 5149.510796474329, 5152.948470515322, 5159.17453207485, 6130.356312587203, 6262.906056409066, 6271.247450305992, 6387.073874288202, 6395.0, 6187.504999600112, 6238.469730072995, 6238.625682459067, 6243.282022567372, 6246.0, 6313.936860631518, 6348.143000694847, 6350.460210881942, 6356.809295721136, 6363.904541431974, 5838.970805145947, 5985.581009329305, 6018.699065046818, 6097.695115244132, 6110.51115910735, 6227.626342419469, 6234.1583886174785, 6235.064740288993, 6240.968795155995, 6246.125542424155, 6019.277686677627, 6061.212042434631, 6073.448435378344, 6074.3925607438905, 6077.453029227214, 5792.275965504312, 5943.494802941798, 5984.401559843981, 6083.330833608388, 6115.235595550556, 5942.6731529766275, 5996.760129594767, 5997.13041608973, 6005.3694362091355, 6018.398160183947, 6059.242594675666, 6066.848328791815, 6078.696065196811, 6100.298465676504, 6102.420270074336, 5760.1935728998815, 5800.0, 5888.499477544286, 5940.554458415722, 5941.702914854326], "value": 5665.357813886261, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [600.9248843894513, 642.9196350456192, 663.0683889135765, 664.2493981800565, 719.154992883362, 42078.57921420785, 46697.299540506916, 46704.0, 46737.0, 46806.76596617012, 46799.0, 47189.76405117969, 47424.762876185574, 47469.762651186786, 47499.28751068728, 9131.132542408477, 9242.0, 9254.444733316022, 9256.583453744564, 9277.768055798591, 9134.817303653956, 9205.355625106211, 9215.907840921573, 9248.075192480765, 9250.953745231265, 9258.814823703522, 9268.814623707522, 9304.11610896967, 9304.395214311047, 9305.95347023264, 9180.724578262629, 9194.862077068849, 9209.58556864936, 9239.122283383067, 9253.35226534143, 9171.908280917172, 9213.677521286723, 9219.216366608845, 9247.537623118884, 9253.02843201461, 36497.63502364969, 36719.449208261896, 36941.0, 36959.815200924095, 37000.81499592512, 3789.5263092113487, 3873.573906870242, 4042.393640953851, 4149.647279981175, 4677.74272415017, 34775.652243477496, 35048.12379690503, 35336.0, 35887.0, 36423.81788091043, 4234.216669916044, 4374.365716971021, 4449.6662750293535, 4465.10697860426, 4490.169318676056, 354836.0, 355310.0, 357631.0, 358014.0, 358493.0, 68121.65939170272, 68192.0, 68710.0, 68765.0, 68783.0, 39281.214375712894, 40370.990725232106, 40700.0, 42319.57680423218, 42335.0, 15861.048337099812, 15891.523254302389, 15932.123733194785, 15938.760918586231, 15950.521484355488, 13956.581302560737, 13977.0, 13998.510052148125, 14040.508582199574, 14054.508092216927, 21089.261875834272, 21145.365639030853, 21160.788392115883, 21282.787172128392, 21578.136874525157, 7488.251174882468, 7552.9244707552225, 7760.146383897767, 7829.491083079582, 7893.250141236574, 1034.7206254311293, 1086.603389762731, 1099.7360633447915, 1162.430409099552, 1250.9374531273581, 34866.47700284498, 35289.0, 35338.646613533536, 35351.823240883634, 36087.0, 1090.9908334790287, 1234.4321612058375, 1236.9319687417278, 1249.5876360800914, 1277.4379273119798, 17938.730919036225, 18605.0, 18736.344227952228, 18847.24611015544, 18865.0, 567066.0, 570629.0, 570693.0, 572033.0, 574889.0, 66569.33430665729, 66922.0, 66942.66528667326, 67053.0, 67229.66385168042, 1456.089943785113, 1457.679310551677, 1458.5332693538178, 1495.2523738130935, 1499.8650121489118, 33792.66207337895, 34135.82932085423, 34194.31611367709, 34207.65792342045, 34346.65653343435, 58421.4157858416, 58903.11645325409, 59015.0, 59034.40965590289, 59041.0, 453911.0, 459317.0, 460422.0, 461825.0, 461904.0, 28606.284842878264, 29006.27484312909, 29029.419411611227, 29167.416651667274, 29193.0, 53569.73215133899, 54609.907801844536, 54630.72684636551, 54841.1773823385, 55812.0, 46379.0, 47694.52305476901, 48055.75972120117, 48464.0, 48466.95118246771, 47166.52833471621, 47784.283235752184, 47873.281900772214, 48169.0, 48677.0, 45371.319430207914, 46354.76822615865, 46798.53201468078, 47378.05243895034, 48391.5160848387, 39406.802965984985, 40153.79923100366, 40372.1925561493, 40790.59209407868, 41234.0, 30169.69830301669, 31156.53265201069, 31406.685933140376, 31421.0, 31575.368492630478], "value": 21437.43464803494, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [429.8608686979502, 437.23920378541334, 439.13052156729674, 441.29392971246, 449.9067266542301, 19432.0, 20358.491037724063, 20935.47661308468, 21242.25652102177, 21261.68107478389, 19284.807151928475, 19848.801511984875, 20753.0, 20889.164433422684, 20902.790972090275, 5687.687177205242, 5928.170056192136, 5933.406659334075, 5941.079132734411, 5942.346341902387, 5859.209006784094, 5862.853428664296, 5868.061110222366, 5888.5877988540815, 5894.233749612545, 5810.418958104198, 5819.185314056035, 5836.474717275444, 5838.737256823432, 5845.415458454163, 5686.346070201917, 5831.912521312183, 5881.82354529367, 5900.1739756434135, 5968.283805943272, 5722.484976352148, 5795.884082318372, 5822.068469044975, 5877.735501902424, 5910.67491287979, 13872.375743091585, 14079.788803167961, 14085.15489070659, 14171.433142674281, 14449.638759031002, 2375.988120059406, 2410.505846301504, 2534.7845433138204, 2540.5300019496453, 2804.2288370698016, 10906.400147991857, 12006.879931200663, 12323.445444955, 14640.341184646717, 15640.2179891005, 1835.843953263974, 2031.4007367826528, 2067.359118673216, 2099.7585277692956, 2119.205298013245, 83449.58275208584, 85261.57369213115, 86700.0, 86759.13240867574, 86933.0, 10780.353178809297, 10818.459077046116, 10890.61882834097, 11232.438378081226, 12082.516699332104, 16945.237464314134, 16966.575835603962, 16978.23597938096, 16984.91507542479, 16992.405265815636, 7535.058117735283, 7845.960770196112, 7892.84214315722, 8014.759557213293, 8594.914050859412, 7375.8156046099275, 7550.093988721389, 7552.735654252075, 7580.0, 7789.104253010976, 4936.136176169156, 5000.499950004971, 5017.523335283142, 5135.6918584885025, 5198.974005130026, 2137.070374387147, 2138.5295235048266, 2178.8256939445123, 2198.703175071345, 2218.057325636598, 467.11015515443137, 468.833564084745, 487.9316895634614, 1029.2177944762034, 1094.8467214589964, 11529.423528823525, 12513.874861251454, 12708.5650723025, 12756.681082973, 12776.808347874789, 421.29012613745937, 426.79727129613184, 466.74562363511967, 470.58353357279054, 506.69851438394096, 6823.658817059128, 7048.612326322102, 7058.54119482232, 7075.858482830417, 7187.0, 485394.0, 493858.0, 494806.0, 534951.3009739784, 559420.0, 64245.678771605846, 72258.63870680613, 97560.0, 98227.50886245523, 101791.0, 501.1605560685837, 509.6687153350352, 510.1276816643507, 510.8595136337537, 510.9948900510947, 11592.478338474957, 11812.0, 11886.108541859569, 12047.698807529881, 12110.333931633493, 41447.37828932629, 42062.0, 42885.57114428816, 43638.56361436345, 43963.12073758571, 60422.0, 62895.6855215721, 63797.68101159464, 64686.353136469916, 65085.02372464322, 8778.734556345938, 8857.601407936787, 8896.733098007071, 9059.63761449561, 9116.1339672731, 10269.383836969806, 12992.675183120498, 13260.469581217028, 13497.932510337778, 13656.385462654403, 12323.50705971787, 12387.504499820267, 12498.25010499373, 12523.624291271277, 12683.682907927006, 12183.086268529718, 12221.388930553614, 12238.510459581874, 12238.816417753562, 12468.750624987631, 12330.0, 12461.1900226485, 12518.749625007631, 12609.810852837398, 12757.425915833996, 8660.653573856975, 8675.219230269306, 8950.507722075088, 9029.142231487998, 9264.212541934012, 11974.58088966882, 12206.877931220573, 12213.572524961584, 12330.136890417585, 12330.136890417585], "value": 8695.639182521709, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1547.4815936661214, 1557.3069983857185, 1758.323045627433, 1799.6580649676569, 1865.5709186887016, 9175.265978721704, 9322.067793220684, 9397.1072748089, 10149.898501014988, 10158.1873450124, 9846.753831154225, 9978.35140715853, 10040.447775372351, 10044.648437304677, 10103.595856165763, 2479.9132030378987, 2504.9749502505015, 2517.244826552036, 2520.407704189514, 2522.672052633164, 2418.093215044358, 2423.1882319423016, 2423.466837295801, 2426.9878650606724, 2430.732619411863, 2437.8049756019564, 2441.170002199252, 2476.554220240356, 2487.6019836826113, 2502.2618327593405, 2107.631164546206, 2117.1848838197407, 2121.342383861, 2124.72378590783, 2135.95728085439, 2332.8250381221305, 2343.7890589846997, 2346.988265058681, 2348.8825558721996, 2353.2469609724894, 9973.451460169688, 10033.498325083716, 10080.64717734883, 10092.293539452241, 10103.898961010369, 5579.832605021856, 5714.914276285859, 5721.0, 5725.685087320196, 5738.167965645, 3581.086822860154, 3605.0, 3624.9456258156147, 3669.4495825626104, 3673.7061035117395, 1258.9496420143275, 1265.5823578219258, 1272.0713878868385, 1302.5766625846638, 1325.5890673891124, 13199.472021119143, 13241.668958276121, 13269.86730132696, 13272.203667779964, 13335.333233338295, 4301.698881078357, 4462.6876118672035, 4604.769761511911, 4638.2115040443205, 4653.744044077541, 10385.740356491147, 10443.738906527398, 10446.68659940203, 10513.106385957126, 10518.579256829642, 5451.918221226685, 5484.91772623411, 5489.972550137224, 5511.22842802008, 5511.862203444865, 4692.671512994126, 5060.911903940597, 5130.538251557377, 5137.460566640449, 5189.584833213334, 4030.717849750489, 4104.91790164195, 4138.896527586834, 4150.232207041707, 4179.895502612459, 1161.5469966712988, 1168.7662467506532, 1172.7595842852195, 1179.0920990837008, 1196.6649338185323, 920.9079092090738, 986.1124987511297, 1003.6938733686296, 1017.1557607186018, 1021.8671572695501, 6123.050927106306, 6226.688665566703, 6353.396427339396, 6372.0, 6507.7071531781185, 454.6226631895519, 457.37339844413367, 463.03688328277104, 464.81639752297656, 473.8815296175956, 4244.129953359554, 4283.357496375568, 4314.633256173198, 4341.5007274163245, 4344.413504176959, 12056.095792815573, 12512.436940337706, 12590.748185036431, 12639.05207109452, 12640.304783236827, 11429.885701142883, 12447.253164810141, 12509.687257818445, 12527.185732927514, 12557.623271301876, 8785.560721963877, 9248.861267081, 9264.768380790534, 9271.397359171633, 9288.164065234027, 6294.874102518015, 6353.14232578596, 6363.0, 6467.126937863328, 6529.640869752209, 11313.0, 11375.601853935073, 11440.313581185155, 11504.079673626256, 11574.71063223426, 11398.373089480157, 11592.768144636892, 11681.240719353214, 11851.288922664668, 11933.164678472423, 7598.886016709865, 8395.160483951557, 8639.568021599021, 8716.60775265102, 8819.559022049, 9574.712758617252, 9617.951910240685, 9640.469774162488, 9641.37331073478, 9659.372140810825, 8259.504429733995, 8322.417430779788, 8343.707970221014, 8414.24271815515, 8560.14398560139, 8560.529170895661, 8608.741737747878, 8646.870296945677, 8648.78378040554, 8672.089430609947, 7958.641861116148, 7968.282854543119, 8043.879341809995, 8047.356211503183, 8058.435909486279, 5261.552768014762, 5292.9735351323, 5424.538914192338, 5452.0731475648445, 5492.697901615449, 5552.389237183826, 5566.387697353369, 5570.498655121059, 5623.971880140573, 5657.5473962082115], "value": 4876.665864987209, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.883079752884, 344.6605093982428, 347.782635852592, 350.13516613963515, 351.10643412515145, 5741.885162296751, 5745.2476994516655, 5782.161586569945, 5796.217510636063, 5812.157237200603, 5653.802116925908, 5656.91514627281, 5733.827985160441, 5736.397678243777, 5737.827865164041, 4241.830326786925, 4330.393744875704, 4456.643468522527, 4496.9207390226275, 4498.67098347224, 4497.910041799162, 4498.775061246941, 4515.774211289438, 4515.796789144496, 4519.299508576176, 4457.710248833815, 4473.932891006638, 4476.664250181233, 4480.977595112036, 4485.9551404485865, 4315.482142142947, 4434.379186913835, 4468.687191896569, 4480.395146655193, 4488.304312831517, 3957.7823219722904, 3972.483577134983, 3973.7615743055508, 3975.363941769303, 3993.5407428145845, 5549.639273447254, 5561.4716601922755, 5564.081926482126, 5569.582281328917, 5570.3315602127595, 4982.725950072744, 5141.562967147797, 5166.61250406221, 5172.379314482248, 5182.740862956837, 5985.670788106652, 5986.191864098335, 5993.7712768882275, 5994.730237139339, 6003.309619393782, 4289.1421715657, 4366.820958341262, 4388.078503514266, 4396.604305612478, 4400.11997600478, 6186.823893871664, 6213.751449941997, 6214.0, 6221.751129954796, 6255.280642726099, 4489.528599497071, 4489.663275254369, 4503.324501324828, 4522.932156017662, 4524.457065152203, 4123.072308730571, 4523.705959112713, 4532.546745325507, 4538.0, 4566.13243483737, 5008.273800298936, 5029.270755740397, 5036.143855544493, 5048.7728052237735, 5052.747362631853, 6019.307779605314, 6049.820285044374, 6052.848678783065, 6057.666828324396, 6086.3000754913755, 1454.70178613384, 1508.2835653064706, 1509.3736099518796, 1520.186700115455, 1527.114273721239, 972.8929817720045, 976.6630512473185, 1007.3351587952063, 1023.9692809215735, 1035.2142554094128, 5817.563682723812, 5836.358000619928, 5905.498032667271, 5932.5550583705535, 5935.347111817697, 6118.265808103056, 6200.968995154995, 6205.5345849061505, 6212.54005308752, 6213.782517611862, 5695.515881150149, 5758.193852860602, 5836.182934389189, 5850.444207800252, 5853.570768131178, 3259.7881137726445, 3295.950560741591, 3317.9004629861142, 3318.5354050432957, 3318.6681331867103, 6135.478484328793, 6316.368363163739, 6338.936610633927, 6364.395382438661, 6375.489960803125, 6267.9287149296515, 6298.527610429236, 6300.621962682254, 6304.148939893055, 6320.209973753281, 6140.556969112255, 6337.366263373718, 6344.397282258178, 6354.364563543609, 6380.0, 6113.510919126548, 6153.2616086068165, 6155.322914479314, 6176.166217560572, 6179.165812615419, 6047.274327080779, 6079.021279573066, 6081.726322315595, 6089.0, 6096.8780624388155, 6100.511959043355, 6315.936840631535, 6320.304766475592, 6338.366163383625, 6340.841478962879, 4343.565643435758, 4345.913081738411, 4346.239772891984, 4353.172897149531, 4355.237833379083, 5916.645001299936, 6147.186579958833, 6157.261128664589, 6157.261128664589, 6158.199434073542, 5977.6114552553945, 5993.940060599338, 6020.946334391551, 6023.795240951739, 6040.939590604038, 5979.790707325223, 5993.910091348546, 5999.800039991932, 6014.518838492998, 6022.819315420545, 5768.0, 5896.380880007538, 5899.91150132757, 5966.3735307793795, 6075.2405949256345, 6168.290646575701, 6168.691565421621, 6173.104899789595, 6173.876522469615, 6200.224971878515, 5807.725117543117, 5998.880022399615, 6000.609960352563, 6002.189704389852, 6019.247594050744], "value": 4589.039943534794, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [831.5135645647296, 856.9742907712771, 880.9999999999999, 908.8682141089546, 929.5723966975194, 16592.004479731226, 17795.19921603528, 17817.198226079825, 17863.642727145467, 17884.37404690836, 15901.602459938507, 15986.12076335801, 16396.426125085625, 16462.094584797862, 17108.572285692862, 844.5228445928046, 846.4455781463151, 871.9302455803552, 872.3457406944791, 873.9431936924111, 869.8956125264978, 876.3602570123813, 877.2368039805378, 878.0736323179044, 879.4020066354876, 902.3638334973828, 909.4815954905706, 909.9363044586881, 910.0171814440422, 912.0651332384293, 907.1925985872579, 908.9091090890925, 909.0909090909091, 909.2089881802808, 909.3770767024544, 672.2605134352174, 672.2840175213382, 672.8183390484542, 673.2426020726682, 673.6463356737703, 16509.257083431276, 16509.83490165095, 16599.6680066398, 16700.08149551774, 16733.497995060166, 16146.567143299711, 16339.83660163395, 16389.754153687703, 16394.83605163945, 16407.1796410179, 12913.741725165539, 13259.27074010929, 13263.734725305536, 13375.53185638498, 14085.0, 4135.379693046068, 4160.91678166438, 4179.1432756284885, 4180.7909604519655, 4271.2738834397915, 81692.59153704194, 81755.0, 81970.59014704949, 82137.0, 82666.0, 12020.939895300642, 12146.817797733042, 12246.81629775554, 12295.692607684701, 12318.445669944875, 23126.190583329502, 23296.76703232946, 23697.7630223699, 24146.637800433007, 24388.390290242533, 9221.677241296522, 9394.201492873046, 9658.855117173249, 9687.854682179774, 9728.221742260603, 4865.7323847188745, 4977.601791856643, 4987.700737955734, 5185.559227465632, 5200.2979597754575, 3763.7553559018575, 3885.4171874218528, 3885.825137868803, 3887.0, 3895.2988462076532, 615.6603562226952, 662.9469642428594, 685.9485538584626, 688.6419062087687, 694.9096617439801, 722.1334398721555, 732.1360794262821, 782.4835608498364, 790.9762707118796, 831.2186544648011, 10321.535530901128, 10384.3250188739, 10430.582776689, 10553.525091370906, 10713.196510261605, 704.2851505721696, 782.9117526637978, 829.4649950781712, 835.1648351648352, 837.3343192162124, 5182.922256166161, 5264.92102618461, 5272.340957380327, 5345.278387417648, 5346.599005074635, 80784.0, 81566.0, 89388.5530572356, 137792.0, 143748.0, 117886.41056794662, 119541.40229298797, 120526.0, 121178.3941080289, 126647.0, 100092.0, 106504.0, 109946.45026774815, 111021.44489277664, 111710.0, 9866.703998880044, 10044.899551004688, 10330.845037324596, 10344.224183186141, 10622.0, 46204.76897615625, 61749.0, 62691.37308627038, 63168.68415658076, 63553.364466354746, 71232.64383678048, 77013.0, 87441.56279218564, 87756.0, 92865.5356723212, 14112.788308175592, 14176.716465670836, 14204.28978551089, 14264.0, 14362.640933976734, 16264.349426022827, 16484.34062637529, 16529.752053718963, 16861.156942153088, 16983.235754390837, 13880.097793643381, 13890.166590004632, 13931.651708707363, 15339.923300383427, 15410.460633877761, 14911.552653420415, 15027.849721502645, 15352.385904563693, 15709.371625134867, 16121.0, 14936.626584335045, 15108.244587770787, 15294.694106118039, 15527.767083493982, 15559.299831507837, 12091.637250882488, 12319.384030798245, 12447.875521245034, 12606.180598261084, 13034.804477933028, 12691.428885699981, 12721.618351449471, 12815.61553153407, 12985.0, 13133.080684352004], "value": 8349.488614479855, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1492.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 112.0, 104.0, 111.0, 112.0, 112.0, 109.0, 111.0, 110.0, 112.0], "value": 109.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 115.0, 139.0, 166.0, 117.0, 142.0, 144.0, 119.0, 176.0, 118.0], "value": 138.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 162.0, 161.0, 160.0, 161.0, 161.0, 161.0, 161.0, 164.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 74.0, 171.0, 79.0, 75.0, 75.0, 76.0, 185.0, 77.0], "value": 96.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 155.0, 84.0, 83.0, 84.0, 148.0, 84.0, 84.0, 140.0], "value": 102.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 148.0, 148.0, 148.0, 148.0, 147.0, 149.0, 148.0, 149.0], "value": 148.0, "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, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 50.0, 50.0, 50.0, 50.0, 50.0, 50.0, 50.0, 52.0, 51.0], "value": 50.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 59.0, 59.0, 59.0, 60.0, 59.0, 59.0, 59.0, 59.0, 59.0], "value": 59.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 73.0, 74.0, 72.0, 74.0, 73.0, 73.0, 73.0, 78.0, 74.0], "value": 73.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 118.0, 120.0, 122.0, 125.0, 129.0, 119.0, 118.0, 153.0, 117.0], "value": 124.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 152.0, 155.0, 152.0, 152.0, 155.0, 153.0, 152.0, 150.0, 159.0], "value": 153.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 65.0, 64.0, 63.0, 62.0, 63.0, 60.0, 61.0, 61.0], "value": 62.1, "unit": "score"}]}]} 10:57:52 INFO - Return code: 0 10:57:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:57:52 ERROR - # TBPL SUCCESS # 10:57:52 INFO - Running post-action listener: _resource_record_post_action 10:57:52 INFO - [mozharness: 2016-10-14 17:57:52.247122Z] Finished run-tests step (success) 10:57:52 INFO - Running post-run listener: _resource_record_post_run 10:57:52 INFO - Total resource usage - Wall time: 1184s; CPU: 13.0%; Read bytes: 12288; Write bytes: 289865728; Read time: 196; Write time: 188876 10:57:52 INFO - TinderboxPrint: CPU usage
13.1% 10:57:52 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 196 10:57:52 INFO - TinderboxPrint: I/O write bytes / time
289,865,728 / 188,876 10:57:52 INFO - TinderboxPrint: CPU idle
8,205.3 (86.8%) 10:57:52 INFO - TinderboxPrint: CPU user
1,190.9 (12.6%) 10:57:52 INFO - TinderboxPrint: Swap in / out
0 / 0 10:57:52 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 4096; Write bytes: 70082560; Read time: 24; Write time: 62640 10:57:52 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 8192; Write bytes: 219783168; Read time: 172; Write time: 126236 10:57:52 INFO - Running post-run listener: _upload_blobber_files 10:57:52 INFO - Blob upload gear active. 10:57:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:57:52 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 10:57:52 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-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:57:52 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-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:57:53 INFO - (blobuploader) - INFO - Open directory for files ... 10:57:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:57:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:57:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:57:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:57:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:57:54 INFO - (blobuploader) - INFO - Done attempting. 10:57:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:57:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:57:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:57:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:57:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:57:57 INFO - (blobuploader) - INFO - Done attempting. 10:57:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:57:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:57:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:57:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:57:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:57:58 INFO - (blobuploader) - INFO - Done attempting. 10:57:58 INFO - (blobuploader) - INFO - Iteration through files over. 10:57:58 INFO - Return code: 0 10:57:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:57:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:57:58 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5d7d4c48696c7c355c652626885e327e0fc253706ab6c5ea34c57660d715ef5fbc31897700c1ecdd29761c7d4a4be9cd44a6a3702edba931207bc5fa68cf2901", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c8b255599ec258684b4716631fc8030dd181ba0e5d85ea694aef7e618d1989da8f913543951d8cc1f096c0ef654a5828cc2a031facdda67c11db986a5bc5bfe5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cf30dc3808e3036a0ea1c6dd9c7e9907599430d04de15c7eb8c732f7de7f33b57665e8645314e8fff056a2d5913d328159597cc1e8e60a87a029e432d541d439"} 10:57:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:57:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:57:58 INFO - Contents: 10:57:58 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5d7d4c48696c7c355c652626885e327e0fc253706ab6c5ea34c57660d715ef5fbc31897700c1ecdd29761c7d4a4be9cd44a6a3702edba931207bc5fa68cf2901", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c8b255599ec258684b4716631fc8030dd181ba0e5d85ea694aef7e618d1989da8f913543951d8cc1f096c0ef654a5828cc2a031facdda67c11db986a5bc5bfe5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cf30dc3808e3036a0ea1c6dd9c7e9907599430d04de15c7eb8c732f7de7f33b57665e8645314e8fff056a2d5913d328159597cc1e8e60a87a029e432d541d439"} 10:57:58 INFO - Running post-run listener: copy_logs_to_upload_dir 10:57:58 INFO - Copying logs to upload dir... 10:57:58 INFO - mkdir: /builds/slave/test/build/upload/logs 10:57:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1671.654651 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 51 secs) (at 2016-10-14 10:57:58.111032) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-14 10:57:58.114425) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1476466203.857261-1810195576 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-Beta/sha512/5d7d4c48696c7c355c652626885e327e0fc253706ab6c5ea34c57660d715ef5fbc31897700c1ecdd29761c7d4a4be9cd44a6a3702edba931207bc5fa68cf2901", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c8b255599ec258684b4716631fc8030dd181ba0e5d85ea694aef7e618d1989da8f913543951d8cc1f096c0ef654a5828cc2a031facdda67c11db986a5bc5bfe5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cf30dc3808e3036a0ea1c6dd9c7e9907599430d04de15c7eb8c732f7de7f33b57665e8645314e8fff056a2d5913d328159597cc1e8e60a87a029e432d541d439"} build_url:https://queue.taskcluster.net/v1/task/G4cSmpsWT4Ofd0HELKBbuQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011331 build_url: 'https://queue.taskcluster.net/v1/task/G4cSmpsWT4Ofd0HELKBbuQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5d7d4c48696c7c355c652626885e327e0fc253706ab6c5ea34c57660d715ef5fbc31897700c1ecdd29761c7d4a4be9cd44a6a3702edba931207bc5fa68cf2901", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c8b255599ec258684b4716631fc8030dd181ba0e5d85ea694aef7e618d1989da8f913543951d8cc1f096c0ef654a5828cc2a031facdda67c11db986a5bc5bfe5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cf30dc3808e3036a0ea1c6dd9c7e9907599430d04de15c7eb8c732f7de7f33b57665e8645314e8fff056a2d5913d328159597cc1e8e60a87a029e432d541d439"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-14 10:57:58.142596) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 10:57:58.143362) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1476466203.857261-1810195576 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004492 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 10:57:58.224771) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-14 10:57:58.225104) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-14 10:57:58.225408) ========= ========= Total master_lag: 0.18 =========