builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-008 starttime: 1474902833.83 results: success (0) buildid: 20160926052750 builduid: 3eaf1eb033a143b7afff768a7349aa06 revision: e613221b195971a2b4a390bf6ca9109e09b99ddf ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-26 08:13:53.831720) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-26 08:13:53.832263) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-26 08:13:53.832578) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-26 08:13:53.900946) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 08:13:53.904338) ========= 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=32c5991c409366f7fec8a718000001d2-1474901408.416707-68565470 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-26 08:13:53-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 50.7M=0s 2016-09-26 08:13:54 (50.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.097952 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 08:13:54.033089) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 08:13:54.033776) ========= 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=32c5991c409366f7fec8a718000001d2-1474901408.416707-68565470 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020987 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 08:13:54.112040) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 08:13:54.112427) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev e613221b195971a2b4a390bf6ca9109e09b99ddf --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 e613221b195971a2b4a390bf6ca9109e09b99ddf --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=32c5991c409366f7fec8a718000001d2-1474901408.416707-68565470 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-26 08:13:54,255 truncating revision to first 12 chars 2016-09-26 08:13:54,255 Setting DEBUG logging. 2016-09-26 08:13:54,255 attempt 1/10 2016-09-26 08:13:54,256 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/e613221b1959?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-26 08:13:54,559 unpacking tar archive at: mozilla-beta-e613221b1959/testing/mozharness/ program finished with exit code 0 elapsedTime=0.699881 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 08:13:54.847071) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-26 08:13:54.847392) ========= script_repo_revision: e613221b195971a2b4a390bf6ca9109e09b99ddf ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-26 08:13:54.847763) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-26 08:13:54.848029) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-26 08:13:54.859371) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 54 secs) (at 2016-09-26 08:13:54.859656) ========= /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=32c5991c409366f7fec8a718000001d2-1474901408.416707-68565470 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:13:55 INFO - MultiFileLogger online at 20160926 08:13:55 in /builds/slave/test 08:13:55 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 08:13:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:13:55 INFO - {'append_to_log': False, 08:13:55 INFO - 'base_work_dir': '/builds/slave/test', 08:13:55 INFO - 'blob_upload_branch': 'Mozilla-Beta', 08:13:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:13:55 INFO - 'branch': 'Mozilla-Beta', 08:13:55 INFO - 'buildbot_json_path': 'buildprops.json', 08:13:55 INFO - 'config_files': ('talos/linux_config.py',), 08:13:55 INFO - 'default_actions': ('clobber', 08:13:55 INFO - 'read-buildbot-config', 08:13:55 INFO - 'download-and-extract', 08:13:55 INFO - 'populate-webroot', 08:13:55 INFO - 'create-virtualenv', 08:13:55 INFO - 'install', 08:13:55 INFO - 'run-tests'), 08:13:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:13:55 INFO - 'download_minidump_stackwalk': True, 08:13:55 INFO - 'download_symbols': 'ondemand', 08:13:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:13:55 INFO - 'tooltool.py': '/tools/tooltool.py', 08:13:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:13:55 INFO - '/tools/misc-python/virtualenv.py')}, 08:13:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:13:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:13:55 INFO - 'installer_path': 'installer.exe', 08:13:55 INFO - 'log_level': 'info', 08:13:55 INFO - 'log_name': 'talos', 08:13:55 INFO - 'log_to_console': True, 08:13:55 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:13:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:13:55 INFO - 'opt_config_files': (), 08:13:55 INFO - 'pip_index': False, 08:13:55 INFO - 'sps_profile': False, 08:13:55 INFO - 'sps_profile_interval': 0, 08:13:55 INFO - 'suite': 'dromaeojs-e10s', 08:13:55 INFO - 'system_bits': '32', 08:13:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:13:55 INFO - 'title': 'talos-linux64-ix-008', 08:13:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:13:55 INFO - 'use_talos_json': True, 08:13:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:13:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:13:55 INFO - 'work_dir': 'build'} 08:13:55 INFO - [mozharness: 2016-09-26 15:13:55.074179Z] Running clobber step. 08:13:55 INFO - Running pre-action listener: _resource_record_pre_action 08:13:55 INFO - Running main action method: clobber 08:13:55 INFO - rmtree: /builds/slave/test/build 08:13:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:13:55 INFO - Running post-action listener: _resource_record_post_action 08:13:55 INFO - [mozharness: 2016-09-26 15:13:55.520002Z] Finished clobber step (success) 08:13:55 INFO - [mozharness: 2016-09-26 15:13:55.520102Z] Running read-buildbot-config step. 08:13:55 INFO - Running pre-action listener: _resource_record_pre_action 08:13:55 INFO - Running main action method: read_buildbot_config 08:13:55 INFO - Using buildbot properties: 08:13:55 INFO - { 08:13:55 INFO - "project": "", 08:13:55 INFO - "product": "firefox", 08:13:55 INFO - "script_repo_revision": "production", 08:13:55 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 08:13:55 INFO - "repository": "", 08:13:55 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 08:13:55 INFO - "buildid": "20160926052750", 08:13:55 INFO - "pgo_build": "True", 08:13:55 INFO - "basedir": "/builds/slave/test", 08:13:55 INFO - "buildnumber": 181, 08:13:55 INFO - "slavename": "talos-linux64-ix-008", 08:13:55 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:13:55 INFO - "platform": "ubuntu64_hw", 08:13:55 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 08:13:55 INFO - "branch": "mozilla-beta", 08:13:55 INFO - "repo_path": "releases/mozilla-beta", 08:13:55 INFO - "revision": "e613221b195971a2b4a390bf6ca9109e09b99ddf", 08:13:55 INFO - "stage_platform": "linux64-pgo", 08:13:55 INFO - "builduid": "3eaf1eb033a143b7afff768a7349aa06", 08:13:55 INFO - "slavebuilddir": "test" 08:13:55 INFO - } 08:13:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/Pl5oGT5vQI2YLZqH_E7j4Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2. 08:13:55 INFO - Running post-action listener: _resource_record_post_action 08:13:55 INFO - [mozharness: 2016-09-26 15:13:55.522536Z] Finished read-buildbot-config step (success) 08:13:55 INFO - [mozharness: 2016-09-26 15:13:55.522626Z] Running download-and-extract step. 08:13:55 INFO - Running pre-action listener: _resource_record_pre_action 08:13:55 INFO - Running main action method: download_and_extract 08:13:55 INFO - mkdir: /builds/slave/test/build/tests 08:13:55 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')]} 08:13:55 INFO - https://queue.taskcluster.net/v1/task/Pl5oGT5vQI2YLZqH_E7j4Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:13:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pl5oGT5vQI2YLZqH_E7j4Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 08:13:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pl5oGT5vQI2YLZqH_E7j4Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 08:13:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pl5oGT5vQI2YLZqH_E7j4Q/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 08:13:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pl5oGT5vQI2YLZqH_E7j4Q/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 08:13:55 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pl5oGT5vQI2YLZqH_E7j4Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 08:13:55 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 08:13:55 INFO - retry: Failed, sleeping 30 seconds before retrying 08:14:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pl5oGT5vQI2YLZqH_E7j4Q/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 08:14:25 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pl5oGT5vQI2YLZqH_E7j4Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 08:14:25 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 08:14:25 INFO - retry: Failed, sleeping 60 seconds before retrying 08:15:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pl5oGT5vQI2YLZqH_E7j4Q/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 08:15:25 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pl5oGT5vQI2YLZqH_E7j4Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 08:15:25 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 08:15:25 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pl5oGT5vQI2YLZqH_E7j4Q/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! 08:15:25 INFO - Caught exception: HTTP Error 404: Not Found 08:15:25 INFO - Caught exception: HTTP Error 404: Not Found 08:15:25 INFO - Caught exception: HTTP Error 404: Not Found 08:15:25 INFO - trying https://queue.taskcluster.net/v1/task/Pl5oGT5vQI2YLZqH_E7j4Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 08:15:25 INFO - Downloading https://queue.taskcluster.net/v1/task/Pl5oGT5vQI2YLZqH_E7j4Q/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 08:15:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Pl5oGT5vQI2YLZqH_E7j4Q/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 08:15:26 INFO - Downloaded 1327 bytes. 08:15:26 INFO - Reading from file /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 08:15:26 INFO - Using the following test package requirements: 08:15:26 INFO - {u'common': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'], 08:15:26 INFO - u'cppunittest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 08:15:26 INFO - u'firefox-50.0.en-US.linux-x86_64.cppunittest.tests.zip'], 08:15:26 INFO - u'gtest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 08:15:26 INFO - u'firefox-50.0.en-US.linux-x86_64.gtest.tests.zip'], 08:15:26 INFO - u'jittest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 08:15:26 INFO - u'jsshell-linux-x86_64.zip'], 08:15:26 INFO - u'mochitest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 08:15:26 INFO - u'firefox-50.0.en-US.linux-x86_64.mochitest.tests.zip'], 08:15:26 INFO - u'mozbase': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'], 08:15:26 INFO - u'reftest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 08:15:26 INFO - u'firefox-50.0.en-US.linux-x86_64.reftest.tests.zip'], 08:15:26 INFO - u'talos': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 08:15:26 INFO - u'firefox-50.0.en-US.linux-x86_64.talos.tests.zip'], 08:15:26 INFO - u'web-platform': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 08:15:26 INFO - u'firefox-50.0.en-US.linux-x86_64.web-platform.tests.zip'], 08:15:26 INFO - u'xpcshell': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 08:15:26 INFO - u'firefox-50.0.en-US.linux-x86_64.xpcshell.tests.zip']} 08:15:26 INFO - Downloading packages: [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:15:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:15:26 INFO - https://queue.taskcluster.net/v1/task/Pl5oGT5vQI2YLZqH_E7j4Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:15:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pl5oGT5vQI2YLZqH_E7j4Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 08:15:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pl5oGT5vQI2YLZqH_E7j4Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 08:15:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pl5oGT5vQI2YLZqH_E7j4Q/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 08:15:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pl5oGT5vQI2YLZqH_E7j4Q/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 08:15:26 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pl5oGT5vQI2YLZqH_E7j4Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 08:15:26 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 08:15:26 INFO - retry: Failed, sleeping 30 seconds before retrying 08:15:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pl5oGT5vQI2YLZqH_E7j4Q/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 08:15:56 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pl5oGT5vQI2YLZqH_E7j4Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 08:15:56 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 08:15:56 INFO - retry: Failed, sleeping 60 seconds before retrying 08:16:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pl5oGT5vQI2YLZqH_E7j4Q/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 08:16:56 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pl5oGT5vQI2YLZqH_E7j4Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 08:16:56 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 08:16:56 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pl5oGT5vQI2YLZqH_E7j4Q/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! 08:16:56 INFO - Caught exception: HTTP Error 404: Not Found 08:16:56 INFO - Caught exception: HTTP Error 404: Not Found 08:16:56 INFO - Caught exception: HTTP Error 404: Not Found 08:16:56 INFO - trying https://queue.taskcluster.net/v1/task/Pl5oGT5vQI2YLZqH_E7j4Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 08:16:56 INFO - Downloading https://queue.taskcluster.net/v1/task/Pl5oGT5vQI2YLZqH_E7j4Q/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 08:16:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Pl5oGT5vQI2YLZqH_E7j4Q/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 08:16:57 INFO - Downloaded 21772475 bytes. 08:16:57 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'] 08:16:57 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 08:16:58 INFO - Return code: 0 08:16:58 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 08:16:58 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')]} 08:16:58 INFO - https://queue.taskcluster.net/v1/task/Pl5oGT5vQI2YLZqH_E7j4Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:16:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pl5oGT5vQI2YLZqH_E7j4Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 08:16:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pl5oGT5vQI2YLZqH_E7j4Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 08:16:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pl5oGT5vQI2YLZqH_E7j4Q/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 08:16:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pl5oGT5vQI2YLZqH_E7j4Q/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 08:16:58 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pl5oGT5vQI2YLZqH_E7j4Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 08:16:58 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 08:16:58 INFO - retry: Failed, sleeping 30 seconds before retrying 08:17:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pl5oGT5vQI2YLZqH_E7j4Q/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 08:17:28 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pl5oGT5vQI2YLZqH_E7j4Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 08:17:28 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 08:17:28 INFO - retry: Failed, sleeping 60 seconds before retrying 08:18:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pl5oGT5vQI2YLZqH_E7j4Q/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 08:18:28 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pl5oGT5vQI2YLZqH_E7j4Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 08:18:28 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 08:18:28 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pl5oGT5vQI2YLZqH_E7j4Q/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! 08:18:28 INFO - Caught exception: HTTP Error 404: Not Found 08:18:28 INFO - Caught exception: HTTP Error 404: Not Found 08:18:28 INFO - Caught exception: HTTP Error 404: Not Found 08:18:28 INFO - trying https://queue.taskcluster.net/v1/task/Pl5oGT5vQI2YLZqH_E7j4Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 08:18:28 INFO - Downloading https://queue.taskcluster.net/v1/task/Pl5oGT5vQI2YLZqH_E7j4Q/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 08:18:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Pl5oGT5vQI2YLZqH_E7j4Q/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 08:18:29 INFO - Downloaded 21772475 bytes. 08:18:29 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'] 08:18:29 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 08:18:30 INFO - Return code: 0 08:18:30 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')]} 08:18:30 INFO - https://queue.taskcluster.net/v1/task/Pl5oGT5vQI2YLZqH_E7j4Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:18:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pl5oGT5vQI2YLZqH_E7j4Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 08:18:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pl5oGT5vQI2YLZqH_E7j4Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 08:18:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pl5oGT5vQI2YLZqH_E7j4Q/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 08:18:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pl5oGT5vQI2YLZqH_E7j4Q/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 08:18:30 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pl5oGT5vQI2YLZqH_E7j4Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 08:18:30 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 08:18:30 INFO - retry: Failed, sleeping 30 seconds before retrying 08:19:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pl5oGT5vQI2YLZqH_E7j4Q/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 08:19:00 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pl5oGT5vQI2YLZqH_E7j4Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 08:19:00 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 08:19:00 INFO - retry: Failed, sleeping 60 seconds before retrying 08:20:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pl5oGT5vQI2YLZqH_E7j4Q/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 08:20:00 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pl5oGT5vQI2YLZqH_E7j4Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 08:20:00 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 08:20:00 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pl5oGT5vQI2YLZqH_E7j4Q/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! 08:20:00 INFO - Caught exception: HTTP Error 404: Not Found 08:20:00 INFO - Caught exception: HTTP Error 404: Not Found 08:20:00 INFO - Caught exception: HTTP Error 404: Not Found 08:20:00 INFO - trying https://queue.taskcluster.net/v1/task/Pl5oGT5vQI2YLZqH_E7j4Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 08:20:00 INFO - Downloading https://queue.taskcluster.net/v1/task/Pl5oGT5vQI2YLZqH_E7j4Q/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 08:20:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Pl5oGT5vQI2YLZqH_E7j4Q/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 08:20:02 INFO - Downloaded 14413740 bytes. 08:20:02 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'] 08:20:02 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 08:20:02 INFO - Return code: 0 08:20: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')]} 08:20:02 INFO - https://queue.taskcluster.net/v1/task/Pl5oGT5vQI2YLZqH_E7j4Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:20:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pl5oGT5vQI2YLZqH_E7j4Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 08:20:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pl5oGT5vQI2YLZqH_E7j4Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 08:20:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pl5oGT5vQI2YLZqH_E7j4Q/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 08:20:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pl5oGT5vQI2YLZqH_E7j4Q/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 08:20:02 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pl5oGT5vQI2YLZqH_E7j4Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 08:20:02 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 08:20:02 INFO - retry: Failed, sleeping 30 seconds before retrying 08:20:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pl5oGT5vQI2YLZqH_E7j4Q/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 08:20:32 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pl5oGT5vQI2YLZqH_E7j4Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 08:20:32 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 08:20:32 INFO - retry: Failed, sleeping 60 seconds before retrying 08:21:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pl5oGT5vQI2YLZqH_E7j4Q/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 08:21:32 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pl5oGT5vQI2YLZqH_E7j4Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 08:21:32 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 08:21:32 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pl5oGT5vQI2YLZqH_E7j4Q/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! 08:21:32 INFO - Caught exception: HTTP Error 404: Not Found 08:21:32 INFO - Caught exception: HTTP Error 404: Not Found 08:21:32 INFO - Caught exception: HTTP Error 404: Not Found 08:21:32 INFO - trying https://queue.taskcluster.net/v1/task/Pl5oGT5vQI2YLZqH_E7j4Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 08:21:32 INFO - Downloading https://queue.taskcluster.net/v1/task/Pl5oGT5vQI2YLZqH_E7j4Q/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 08:21:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Pl5oGT5vQI2YLZqH_E7j4Q/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 08:21:34 INFO - Downloaded 56769206 bytes. 08:21:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Pl5oGT5vQI2YLZqH_E7j4Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 08:21:34 INFO - mkdir: /builds/slave/test/properties 08:21:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:21:34 INFO - Writing to file /builds/slave/test/properties/build_url 08:21:34 INFO - Contents: 08:21:34 INFO - build_url:https://queue.taskcluster.net/v1/task/Pl5oGT5vQI2YLZqH_E7j4Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 08:21:35 INFO - Running post-action listener: _resource_record_post_action 08:21:35 INFO - Running post-action listener: set_extra_try_arguments 08:21:35 INFO - [mozharness: 2016-09-26 15:21:35.494269Z] Finished download-and-extract step (success) 08:21:35 INFO - [mozharness: 2016-09-26 15:21:35.494502Z] Running populate-webroot step. 08:21:35 INFO - Running pre-action listener: _resource_record_pre_action 08:21:35 INFO - Running main action method: populate_webroot 08:21:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:21:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:21:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:21:35 INFO - '--tppagecycles', 08:21:35 INFO - '7'], 08:21:35 INFO - 'tests': ['tsvgm']}}, 08:21:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:21:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:21:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:21:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:21:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:21:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:21:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:21:35 INFO - 'talos_options': ['--disable-e10s'], 08:21:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:21:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:21:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:21:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:21:35 INFO - 'talos_options': ['--disable-e10s'], 08:21:35 INFO - 'tests': ['damp', 'tps']}, 08:21:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:21:35 INFO - 'tests': ['damp', 'tps']}, 08:21:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:21:35 INFO - 'tests': ['dromaeo_dom']}, 08:21:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:21:35 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:21:35 INFO - 'tests': ['basic_compositor_video']}, 08:21:35 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:21:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:21:35 INFO - 'tests': ['a11yr', 08:21:35 INFO - 'ts_paint', 08:21:35 INFO - 'tpaint', 08:21:35 INFO - 'sessionrestore', 08:21:35 INFO - 'sessionrestore_no_auto_restore', 08:21:35 INFO - 'tabpaint']}, 08:21:35 INFO - 'other-e10s': {'tests': ['a11yr', 08:21:35 INFO - 'ts_paint', 08:21:35 INFO - 'tpaint', 08:21:35 INFO - 'sessionrestore', 08:21:35 INFO - 'sessionrestore_no_auto_restore', 08:21:35 INFO - 'tabpaint']}, 08:21:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:21:35 INFO - 'ts_paint', 08:21:35 INFO - 'tpaint', 08:21:35 INFO - 'sessionrestore', 08:21:35 INFO - 'sessionrestore_no_auto_restore', 08:21:35 INFO - 'tabpaint']}, 08:21:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:21:35 INFO - 'ts_paint', 08:21:35 INFO - 'tpaint', 08:21:35 INFO - 'sessionrestore', 08:21:35 INFO - 'sessionrestore_no_auto_restore', 08:21:35 INFO - 'tabpaint']}, 08:21:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:21:35 INFO - 'tests': ['a11yr', 08:21:35 INFO - 'ts_paint', 08:21:35 INFO - 'tpaint', 08:21:35 INFO - 'sessionrestore', 08:21:35 INFO - 'sessionrestore_no_auto_restore', 08:21:35 INFO - 'tabpaint']}, 08:21:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:21:35 INFO - 'tests': ['a11yr', 08:21:35 INFO - 'ts_paint', 08:21:35 INFO - 'tpaint', 08:21:35 INFO - 'sessionrestore', 08:21:35 INFO - 'sessionrestore_no_auto_restore', 08:21:35 INFO - 'tabpaint']}, 08:21:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:21:35 INFO - 'tests': ['tsvgx', 08:21:35 INFO - 'tsvgr_opacity', 08:21:35 INFO - 'tart', 08:21:35 INFO - 'tscrollx', 08:21:35 INFO - 'cart']}, 08:21:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:21:35 INFO - 'tsvgr_opacity', 08:21:35 INFO - 'tart', 08:21:35 INFO - 'tscrollx', 08:21:35 INFO - 'cart']}, 08:21:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:21:35 INFO - 'talos_options': ['--disable-e10s'], 08:21:35 INFO - 'tests': ['tp5o']}, 08:21:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:21:35 INFO - 'tests': ['tp5o']}, 08:21:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:21:35 INFO - 'talos_options': ['--disable-e10s', 08:21:35 INFO - '--xperf_path', 08:21:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:21:35 INFO - 'tests': ['tp5n']}, 08:21:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:21:35 INFO - 'talos_options': ['--xperf_path', 08:21:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:21:35 INFO - 'tests': ['tp5n']}}, 08:21:35 INFO - 'talos.zip': {'path': '', 08:21:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:21:35 INFO - Running post-action listener: _resource_record_post_action 08:21:35 INFO - [mozharness: 2016-09-26 15:21:35.512338Z] Finished populate-webroot step (success) 08:21:35 INFO - [mozharness: 2016-09-26 15:21:35.512427Z] Running create-virtualenv step. 08:21:35 INFO - Running pre-action listener: _resource_record_pre_action 08:21:35 INFO - Running main action method: create_virtualenv 08:21:35 INFO - Creating virtualenv /builds/slave/test/build/venv 08:21:35 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 08:21:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:21:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:21:35 INFO - Using real prefix '/usr' 08:21:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:21:36 INFO - Installing distribute.............................................................................................................................................................................................done. 08:21:38 INFO - Installing pip.................done. 08:21:38 INFO - Return code: 0 08:21:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:21:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:38 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 0x20e4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2313400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a2570>, '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 0x23a3470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a3900>, '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': '32c5991c409366f7fec8a718000001d2-1474901408.416707-68565470', '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 08:21:38 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 08:21:38 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 08:21:38 INFO - Using env: {'DISPLAY': ':0', 08:21:38 INFO - 'HOME': '/home/cltbld', 08:21:38 INFO - 'LANG': 'en_US.UTF-8', 08:21:38 INFO - 'LANGUAGE': 'en_US:en', 08:21:38 INFO - 'LOGNAME': 'cltbld', 08:21:38 INFO - 'MAIL': '/var/mail/cltbld', 08:21:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:38 INFO - 'MOZ_NO_REMOTE': '1', 08:21:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:38 INFO - 'NO_EM_RESTART': '1', 08:21:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:38 INFO - 'PWD': '/builds/slave/test', 08:21:38 INFO - 'SHELL': '/bin/bash', 08:21:38 INFO - 'SHLVL': '1', 08:21:38 INFO - 'TERM': 'linux', 08:21:38 INFO - 'TMOUT': '86400', 08:21:38 INFO - 'USER': 'cltbld', 08:21:38 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1474901408.416707-68565470', 08:21:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:38 INFO - '_': '/tools/buildbot/bin/python'} 08:21:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:38 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 08:21:38 INFO - Cleaning up... 08:21:38 INFO - Return code: 0 08:21:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:21:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:38 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 0x20e4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2313400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a2570>, '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 0x23a3470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a3900>, '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': '32c5991c409366f7fec8a718000001d2-1474901408.416707-68565470', '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 08:21:38 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 08:21:38 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 08:21:38 INFO - Using env: {'DISPLAY': ':0', 08:21:38 INFO - 'HOME': '/home/cltbld', 08:21:38 INFO - 'LANG': 'en_US.UTF-8', 08:21:38 INFO - 'LANGUAGE': 'en_US:en', 08:21:38 INFO - 'LOGNAME': 'cltbld', 08:21:38 INFO - 'MAIL': '/var/mail/cltbld', 08:21:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:38 INFO - 'MOZ_NO_REMOTE': '1', 08:21:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:38 INFO - 'NO_EM_RESTART': '1', 08:21:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:38 INFO - 'PWD': '/builds/slave/test', 08:21:38 INFO - 'SHELL': '/bin/bash', 08:21:38 INFO - 'SHLVL': '1', 08:21:38 INFO - 'TERM': 'linux', 08:21:38 INFO - 'TMOUT': '86400', 08:21:38 INFO - 'USER': 'cltbld', 08:21:38 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1474901408.416707-68565470', 08:21:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:38 INFO - '_': '/tools/buildbot/bin/python'} 08:21:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:38 INFO - Downloading/unpacking psutil>=3.1.1 08:21:38 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 08:21:38 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 08:21:38 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 08:21:38 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 08:21:38 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 08:21:38 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 08:21:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:21:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:21:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:21:40 INFO - Installing collected packages: psutil 08:21:40 INFO - Running setup.py install for psutil 08:21:40 INFO - building 'psutil._psutil_linux' extension 08:21:40 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 08:21:40 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 08:21:40 INFO - building 'psutil._psutil_posix' extension 08:21:40 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 08:21:40 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 08:21:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:21:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:21:40 INFO - Successfully installed psutil 08:21:40 INFO - Cleaning up... 08:21:41 INFO - Return code: 0 08:21:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:21:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:41 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 0x20e4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2313400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a2570>, '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 0x23a3470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a3900>, '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': '32c5991c409366f7fec8a718000001d2-1474901408.416707-68565470', '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 08:21:41 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 08:21:41 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 08:21:41 INFO - Using env: {'DISPLAY': ':0', 08:21:41 INFO - 'HOME': '/home/cltbld', 08:21:41 INFO - 'LANG': 'en_US.UTF-8', 08:21:41 INFO - 'LANGUAGE': 'en_US:en', 08:21:41 INFO - 'LOGNAME': 'cltbld', 08:21:41 INFO - 'MAIL': '/var/mail/cltbld', 08:21:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:41 INFO - 'MOZ_NO_REMOTE': '1', 08:21:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:41 INFO - 'NO_EM_RESTART': '1', 08:21:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:41 INFO - 'PWD': '/builds/slave/test', 08:21:41 INFO - 'SHELL': '/bin/bash', 08:21:41 INFO - 'SHLVL': '1', 08:21:41 INFO - 'TERM': 'linux', 08:21:41 INFO - 'TMOUT': '86400', 08:21:41 INFO - 'USER': 'cltbld', 08:21:41 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1474901408.416707-68565470', 08:21:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:41 INFO - '_': '/tools/buildbot/bin/python'} 08:21:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:21:41 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 08:21:41 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 08:21:41 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 08:21:41 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 08:21:41 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 08:21:41 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 08:21:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:21:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:21:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:21:43 INFO - Installing collected packages: mozsystemmonitor 08:21:43 INFO - Running setup.py install for mozsystemmonitor 08:21:43 INFO - Successfully installed mozsystemmonitor 08:21:43 INFO - Cleaning up... 08:21:43 INFO - Return code: 0 08:21:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:21:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:43 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 0x20e4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2313400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a2570>, '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 0x23a3470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a3900>, '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': '32c5991c409366f7fec8a718000001d2-1474901408.416707-68565470', '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 08:21:43 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 08:21:43 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 08:21:43 INFO - Using env: {'DISPLAY': ':0', 08:21:43 INFO - 'HOME': '/home/cltbld', 08:21:43 INFO - 'LANG': 'en_US.UTF-8', 08:21:43 INFO - 'LANGUAGE': 'en_US:en', 08:21:43 INFO - 'LOGNAME': 'cltbld', 08:21:43 INFO - 'MAIL': '/var/mail/cltbld', 08:21:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:43 INFO - 'MOZ_NO_REMOTE': '1', 08:21:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:43 INFO - 'NO_EM_RESTART': '1', 08:21:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:43 INFO - 'PWD': '/builds/slave/test', 08:21:43 INFO - 'SHELL': '/bin/bash', 08:21:43 INFO - 'SHLVL': '1', 08:21:43 INFO - 'TERM': 'linux', 08:21:43 INFO - 'TMOUT': '86400', 08:21:43 INFO - 'USER': 'cltbld', 08:21:43 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1474901408.416707-68565470', 08:21:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:43 INFO - '_': '/tools/buildbot/bin/python'} 08:21:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:43 INFO - Downloading/unpacking jsonschema==2.5.1 08:21:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:21:45 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:21:45 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 08:21:45 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 08:21:45 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 08:21:45 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 08:21:45 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 08:21:45 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 08:21:45 INFO - Downloading functools32-3.2.3-2.tar.gz 08:21:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:21:45 INFO - warning: no files found matching '*.txt' 08:21:45 INFO - no previously-included directories found matching 'build' 08:21:45 INFO - no previously-included directories found matching 'dist' 08:21:45 INFO - no previously-included directories found matching '.git*' 08:21:45 INFO - Installing collected packages: jsonschema, functools32 08:21:45 INFO - Running setup.py install for functools32 08:21:45 INFO - warning: no files found matching '*.txt' 08:21:45 INFO - no previously-included directories found matching 'build' 08:21:45 INFO - no previously-included directories found matching 'dist' 08:21:45 INFO - no previously-included directories found matching '.git*' 08:21:45 INFO - Successfully installed jsonschema functools32 08:21:45 INFO - Cleaning up... 08:21:45 INFO - Return code: 0 08:21:45 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:21:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x20e4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2313400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a2570>, '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 0x23a3470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a3900>, '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': '32c5991c409366f7fec8a718000001d2-1474901408.416707-68565470', '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 08:21:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:21:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:21:45 INFO - Using env: {'DISPLAY': ':0', 08:21:45 INFO - 'HOME': '/home/cltbld', 08:21:45 INFO - 'LANG': 'en_US.UTF-8', 08:21:45 INFO - 'LANGUAGE': 'en_US:en', 08:21:45 INFO - 'LOGNAME': 'cltbld', 08:21:45 INFO - 'MAIL': '/var/mail/cltbld', 08:21:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:45 INFO - 'MOZ_NO_REMOTE': '1', 08:21:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:45 INFO - 'NO_EM_RESTART': '1', 08:21:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:45 INFO - 'PWD': '/builds/slave/test', 08:21:45 INFO - 'SHELL': '/bin/bash', 08:21:45 INFO - 'SHLVL': '1', 08:21:45 INFO - 'TERM': 'linux', 08:21:45 INFO - 'TMOUT': '86400', 08:21:45 INFO - 'USER': 'cltbld', 08:21:45 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1474901408.416707-68565470', 08:21:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:45 INFO - '_': '/tools/buildbot/bin/python'} 08:21:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:46 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:21:46 INFO - Cleaning up... 08:21:46 INFO - Return code: 0 08:21:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:21:46 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')]} 08:21:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:46 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')]} 08:21:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:46 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 0x20e4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2313400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a2570>, '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 0x23a3470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a3900>, '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': '32c5991c409366f7fec8a718000001d2-1474901408.416707-68565470', '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 08:21:46 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 08:21:46 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 08:21:46 INFO - Using env: {'DISPLAY': ':0', 08:21:46 INFO - 'HOME': '/home/cltbld', 08:21:46 INFO - 'LANG': 'en_US.UTF-8', 08:21:46 INFO - 'LANGUAGE': 'en_US:en', 08:21:46 INFO - 'LOGNAME': 'cltbld', 08:21:46 INFO - 'MAIL': '/var/mail/cltbld', 08:21:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:46 INFO - 'MOZ_NO_REMOTE': '1', 08:21:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:46 INFO - 'NO_EM_RESTART': '1', 08:21:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:46 INFO - 'PWD': '/builds/slave/test', 08:21:46 INFO - 'SHELL': '/bin/bash', 08:21:46 INFO - 'SHLVL': '1', 08:21:46 INFO - 'TERM': 'linux', 08:21:46 INFO - 'TMOUT': '86400', 08:21:46 INFO - 'USER': 'cltbld', 08:21:46 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1474901408.416707-68565470', 08:21:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:46 INFO - '_': '/tools/buildbot/bin/python'} 08:21:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:46 INFO - Downloading/unpacking blobuploader==1.2.4 08:21:46 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 08:21:46 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 08:21:46 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 08:21:46 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 08:21:46 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 08:21:46 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 08:21:48 INFO - Downloading blobuploader-1.2.4.tar.gz 08:21:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:21:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:21: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 08:21: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 08:21: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 08:21: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 08:21: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 08:21: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 08:21:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:21:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:21: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 08:21: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 08:21: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 08:21: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 08:21: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 08:21: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 08:21:48 INFO - Downloading docopt-0.6.1.tar.gz 08:21:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:21:48 INFO - Installing collected packages: blobuploader, requests, docopt 08:21:48 INFO - Running setup.py install for blobuploader 08:21:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:21:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:21:49 INFO - Running setup.py install for requests 08:21:49 INFO - Running setup.py install for docopt 08:21:49 INFO - Successfully installed blobuploader requests docopt 08:21:49 INFO - Cleaning up... 08:21:49 INFO - Return code: 0 08:21:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:21:49 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')]} 08:21:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:49 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')]} 08:21:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:49 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 0x20e4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2313400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a2570>, '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 0x23a3470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a3900>, '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': '32c5991c409366f7fec8a718000001d2-1474901408.416707-68565470', '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 08:21:49 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 08:21:49 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 08:21:49 INFO - Using env: {'DISPLAY': ':0', 08:21:49 INFO - 'HOME': '/home/cltbld', 08:21:49 INFO - 'LANG': 'en_US.UTF-8', 08:21:49 INFO - 'LANGUAGE': 'en_US:en', 08:21:49 INFO - 'LOGNAME': 'cltbld', 08:21:49 INFO - 'MAIL': '/var/mail/cltbld', 08:21:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:49 INFO - 'MOZ_NO_REMOTE': '1', 08:21:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:49 INFO - 'NO_EM_RESTART': '1', 08:21:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:49 INFO - 'PWD': '/builds/slave/test', 08:21:49 INFO - 'SHELL': '/bin/bash', 08:21:49 INFO - 'SHLVL': '1', 08:21:49 INFO - 'TERM': 'linux', 08:21:49 INFO - 'TMOUT': '86400', 08:21:49 INFO - 'USER': 'cltbld', 08:21:49 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1474901408.416707-68565470', 08:21:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:49 INFO - '_': '/tools/buildbot/bin/python'} 08:21:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:21:49 INFO - Running setup.py (path:/tmp/pip-X34AxQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:21:49 INFO - Running setup.py (path:/tmp/pip-BUoq6h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:21:49 INFO - Running setup.py (path:/tmp/pip-rPEOlv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:21:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:21:50 INFO - Running setup.py (path:/tmp/pip-P70mhW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:21:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:21:50 INFO - Running setup.py (path:/tmp/pip-j4UBNj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:21:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:21:50 INFO - Running setup.py (path:/tmp/pip-vKt9Oy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:21:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:21:50 INFO - Running setup.py (path:/tmp/pip-H9noeX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:21:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:21:50 INFO - Running setup.py (path:/tmp/pip-uNBkje-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:21:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:21:50 INFO - Running setup.py (path:/tmp/pip-G7xBBW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:21:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:21:50 INFO - Running setup.py (path:/tmp/pip-0EFl3v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:21:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:21:50 INFO - Running setup.py (path:/tmp/pip-dt0528-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:21:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:21:50 INFO - Running setup.py (path:/tmp/pip-cjFZ9U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:21:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:21:50 INFO - Running setup.py (path:/tmp/pip-tc1X_S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:21:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:21:50 INFO - Running setup.py (path:/tmp/pip-wsNYKq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:21:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:21:50 INFO - Running setup.py (path:/tmp/pip-tfrxb2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:21:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:21:50 INFO - Running setup.py (path:/tmp/pip-qmU6Um-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:21:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:21:50 INFO - Running setup.py (path:/tmp/pip-MMjMPj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:21:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:21:51 INFO - Running setup.py install for manifestparser 08:21:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:21:51 INFO - Running setup.py install for mozcrash 08:21:51 INFO - Running setup.py install for mozdebug 08:21:51 INFO - Running setup.py install for mozdevice 08:21:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:21:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:21:51 INFO - Running setup.py install for mozfile 08:21:51 INFO - Running setup.py install for mozhttpd 08:21:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:21:51 INFO - Running setup.py install for mozinfo 08:21:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:21:51 INFO - Running setup.py install for mozInstall 08:21:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:21:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:21:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:21:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:21:51 INFO - Running setup.py install for mozleak 08:21:51 INFO - Running setup.py install for mozlog 08:21:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:21:52 INFO - Running setup.py install for moznetwork 08:21:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:21:52 INFO - Running setup.py install for mozprocess 08:21:52 INFO - Running setup.py install for mozprofile 08:21:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:21:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:21:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:21:52 INFO - Running setup.py install for mozrunner 08:21:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:21:52 INFO - Running setup.py install for mozscreenshot 08:21:52 INFO - Running setup.py install for moztest 08:21:52 INFO - Running setup.py install for mozversion 08:21:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:21:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:21:52 INFO - Cleaning up... 08:21:52 INFO - Return code: 0 08:21:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:21:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:52 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 0x20e4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2313400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a2570>, '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 0x23a3470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a3900>, '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': '32c5991c409366f7fec8a718000001d2-1474901408.416707-68565470', '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 08:21:52 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 08:21:52 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 08:21:52 INFO - Using env: {'DISPLAY': ':0', 08:21:52 INFO - 'HOME': '/home/cltbld', 08:21:52 INFO - 'LANG': 'en_US.UTF-8', 08:21:52 INFO - 'LANGUAGE': 'en_US:en', 08:21:52 INFO - 'LOGNAME': 'cltbld', 08:21:52 INFO - 'MAIL': '/var/mail/cltbld', 08:21:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:52 INFO - 'MOZ_NO_REMOTE': '1', 08:21:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:52 INFO - 'NO_EM_RESTART': '1', 08:21:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:52 INFO - 'PWD': '/builds/slave/test', 08:21:52 INFO - 'SHELL': '/bin/bash', 08:21:52 INFO - 'SHLVL': '1', 08:21:52 INFO - 'TERM': 'linux', 08:21:52 INFO - 'TMOUT': '86400', 08:21:52 INFO - 'USER': 'cltbld', 08:21:52 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1474901408.416707-68565470', 08:21:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:52 INFO - '_': '/tools/buildbot/bin/python'} 08:21:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:21:53 INFO - Running setup.py (path:/tmp/pip-bkLgMo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:21:53 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)) 08:21:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:21:53 INFO - Running setup.py (path:/tmp/pip-IkCQku-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:21:53 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)) 08:21:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:21:53 INFO - Running setup.py (path:/tmp/pip-b_uY1X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:21:53 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)) 08:21:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:21:53 INFO - Running setup.py (path:/tmp/pip-3ovf8u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:21:53 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)) 08:21:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:21:53 INFO - Running setup.py (path:/tmp/pip-_p7yRx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:21:53 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)) 08:21:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:21:53 INFO - Running setup.py (path:/tmp/pip-0DhHb7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:21:53 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)) 08:21:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:21:53 INFO - Running setup.py (path:/tmp/pip-E_bk9H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:21:53 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)) 08:21:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:21:53 INFO - Running setup.py (path:/tmp/pip-K4TxIl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:21:53 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)) 08:21:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:21:53 INFO - Running setup.py (path:/tmp/pip-mmUt63-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:21:53 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)) 08:21:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:21:53 INFO - Running setup.py (path:/tmp/pip-hZZhTr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:21:53 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)) 08:21:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:21:53 INFO - Running setup.py (path:/tmp/pip-KvW19E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:21:53 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)) 08:21:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:21:53 INFO - Running setup.py (path:/tmp/pip-BgOQk9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:21:53 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)) 08:21:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:21:53 INFO - Running setup.py (path:/tmp/pip-YcE2BD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:21:53 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)) 08:21:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:21:53 INFO - Running setup.py (path:/tmp/pip-3sPRvI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:21:54 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)) 08:21:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:21:54 INFO - Running setup.py (path:/tmp/pip-Du7tsS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:21:54 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)) 08:21:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:21:54 INFO - Running setup.py (path:/tmp/pip-AH_FF_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:21:54 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)) 08:21:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:21:54 INFO - Running setup.py (path:/tmp/pip-JFBMj0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:21:54 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)) 08:21:54 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)) 08:21:54 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)) 08:21:54 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)) 08:21:54 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)) 08:21:54 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)) 08:21:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:21:54 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 08:21:54 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 08:21:54 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 08:21:54 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 08:21:54 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 08:21:54 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 08:21:56 INFO - Downloading blessings-1.6.tar.gz 08:21:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:21:56 INFO - Installing collected packages: blessings 08:21:56 INFO - Running setup.py install for blessings 08:21:56 INFO - Successfully installed blessings 08:21:56 INFO - Cleaning up... 08:21:56 INFO - Return code: 0 08:21:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:21:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:21:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:21:56 INFO - Reading from file tmpfile_stdout 08:21:56 INFO - Current package versions: 08:21:56 INFO - argparse == 1.2.1 08:21:56 INFO - blessings == 1.6 08:21:56 INFO - blobuploader == 1.2.4 08:21:56 INFO - docopt == 0.6.1 08:21:56 INFO - functools32 == 3.2.3-2 08:21:56 INFO - jsonschema == 2.5.1 08:21:56 INFO - manifestparser == 1.1 08:21:56 INFO - mozInstall == 1.12 08:21:56 INFO - mozcrash == 0.17 08:21:56 INFO - mozdebug == 0.1 08:21:56 INFO - mozdevice == 0.48 08:21:56 INFO - mozfile == 1.2 08:21:56 INFO - mozhttpd == 0.7 08:21:56 INFO - mozinfo == 0.9 08:21:56 INFO - mozleak == 0.1 08:21:56 INFO - mozlog == 3.3 08:21:56 INFO - moznetwork == 0.27 08:21:56 INFO - mozprocess == 0.23 08:21:56 INFO - mozprofile == 0.28 08:21:56 INFO - mozrunner == 6.12 08:21:56 INFO - mozscreenshot == 0.1 08:21:56 INFO - mozsystemmonitor == 0.3 08:21:56 INFO - moztest == 0.7 08:21:56 INFO - mozversion == 1.4 08:21:56 INFO - psutil == 3.1.1 08:21:56 INFO - requests == 1.2.3 08:21:56 INFO - wsgiref == 0.1.2 08:21:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:21: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')]} 08:21:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21: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')]} 08:21:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:56 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 0x20e4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2313400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a2570>, '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 0x23a3470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a3900>, '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': '32c5991c409366f7fec8a718000001d2-1474901408.416707-68565470', '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 08:21:56 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 08:21:56 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 08:21:56 INFO - Using env: {'DISPLAY': ':0', 08:21:56 INFO - 'HOME': '/home/cltbld', 08:21:56 INFO - 'LANG': 'en_US.UTF-8', 08:21:56 INFO - 'LANGUAGE': 'en_US:en', 08:21:56 INFO - 'LOGNAME': 'cltbld', 08:21:56 INFO - 'MAIL': '/var/mail/cltbld', 08:21:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:56 INFO - 'MOZ_NO_REMOTE': '1', 08:21:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:56 INFO - 'NO_EM_RESTART': '1', 08:21:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:56 INFO - 'PWD': '/builds/slave/test', 08:21:56 INFO - 'SHELL': '/bin/bash', 08:21:56 INFO - 'SHLVL': '1', 08:21:56 INFO - 'TERM': 'linux', 08:21:56 INFO - 'TMOUT': '86400', 08:21:56 INFO - 'USER': 'cltbld', 08:21:56 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1474901408.416707-68565470', 08:21:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:56 INFO - '_': '/tools/buildbot/bin/python'} 08:21:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:56 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)) 08:21:56 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)) 08:21:56 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)) 08:21:56 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)) 08:21:56 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)) 08:21:56 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)) 08:21:56 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)) 08:21:56 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)) 08:21:56 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)) 08:21:56 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)) 08:21:56 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)) 08:21:56 INFO - Cleaning up... 08:21:56 INFO - Return code: 0 08:21:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:21: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')]} 08:21:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21: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')]} 08:21:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2313400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a2570>, '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 0x23a3470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a3900>, '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': '32c5991c409366f7fec8a718000001d2-1474901408.416707-68565470', '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 08:21: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', 'jsonschema'] in /builds/slave/test/build 08:21: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 jsonschema 08:21:56 INFO - Using env: {'DISPLAY': ':0', 08:21:56 INFO - 'HOME': '/home/cltbld', 08:21:56 INFO - 'LANG': 'en_US.UTF-8', 08:21:56 INFO - 'LANGUAGE': 'en_US:en', 08:21:56 INFO - 'LOGNAME': 'cltbld', 08:21:56 INFO - 'MAIL': '/var/mail/cltbld', 08:21:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:56 INFO - 'MOZ_NO_REMOTE': '1', 08:21:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:56 INFO - 'NO_EM_RESTART': '1', 08:21:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:56 INFO - 'PWD': '/builds/slave/test', 08:21:56 INFO - 'SHELL': '/bin/bash', 08:21:56 INFO - 'SHLVL': '1', 08:21:56 INFO - 'TERM': 'linux', 08:21:56 INFO - 'TMOUT': '86400', 08:21:56 INFO - 'USER': 'cltbld', 08:21:56 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1474901408.416707-68565470', 08:21:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:56 INFO - '_': '/tools/buildbot/bin/python'} 08:21:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:57 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:21:57 INFO - Cleaning up... 08:21:57 INFO - Return code: 0 08:21:57 INFO - Running post-action listener: _resource_record_post_action 08:21:57 INFO - Running post-action listener: _start_resource_monitoring 08:21:57 INFO - Starting resource monitoring. 08:21:57 INFO - [mozharness: 2016-09-26 15:21:57.069737Z] Finished create-virtualenv step (success) 08:21:57 INFO - [mozharness: 2016-09-26 15:21:57.070213Z] Running install step. 08:21:57 INFO - Running pre-action listener: _resource_record_pre_action 08:21:57 INFO - Running main action method: install 08:21:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:21:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:21:57 INFO - Reading from file tmpfile_stdout 08:21:57 INFO - Detecting whether we're running mozinstall >=1.0... 08:21:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:21:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:21:57 INFO - Reading from file tmpfile_stdout 08:21:57 INFO - Output received: 08:21:57 INFO - Usage: mozinstall [options] installer 08:21:57 INFO - Options: 08:21:57 INFO - -h, --help show this help message and exit 08:21:57 INFO - -d DEST, --destination=DEST 08:21:57 INFO - Directory to install application into. [default: 08:21:57 INFO - "/builds/slave/test"] 08:21:57 INFO - --app=APP Application being installed. [default: firefox] 08:21:57 INFO - mkdir: /builds/slave/test/build/application 08:21:57 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'] 08:21:57 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 08:22:11 INFO - Reading from file tmpfile_stdout 08:22:11 INFO - Output received: 08:22:11 INFO - /builds/slave/test/build/application/firefox/firefox 08:22:11 INFO - Running post-action listener: _resource_record_post_action 08:22:11 INFO - [mozharness: 2016-09-26 15:22:11.620856Z] Finished install step (success) 08:22:11 INFO - [mozharness: 2016-09-26 15:22:11.621135Z] Running run-tests step. 08:22:11 INFO - Running pre-action listener: _resource_record_pre_action 08:22:11 INFO - Running main action method: run_tests 08:22:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:22:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:22:11 INFO - Python 2.7.3 08:22:11 INFO - Return code: 0 08:22:11 INFO - grabbing minidump binary from tooltool 08:22:11 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')]} 08:22:11 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 0x23a2570>, '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 0x23a3470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a3900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:22:11 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 08:22:11 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 08:22:11 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 08:22:11 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:22:11 INFO - Return code: 0 08:22:11 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:22:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:22:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:22:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:22:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:22:11 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/Pl5oGT5vQI2YLZqH_E7j4Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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 08:22:11 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/Pl5oGT5vQI2YLZqH_E7j4Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-008 --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 08:22:11 INFO - Using env: {'DISPLAY': ':0', 08:22:11 INFO - 'HOME': '/home/cltbld', 08:22:11 INFO - 'LANG': 'en_US.UTF-8', 08:22:11 INFO - 'LANGUAGE': 'en_US:en', 08:22:11 INFO - 'LOGNAME': 'cltbld', 08:22:11 INFO - 'MAIL': '/var/mail/cltbld', 08:22:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:22:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:22:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:22:11 INFO - 'MOZ_NO_REMOTE': '1', 08:22:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:22:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:22:11 INFO - 'NO_EM_RESTART': '1', 08:22:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:22:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:22:11 INFO - 'PWD': '/builds/slave/test', 08:22:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:22:11 INFO - 'SHELL': '/bin/bash', 08:22:11 INFO - 'SHLVL': '1', 08:22:11 INFO - 'TERM': 'linux', 08:22:11 INFO - 'TMOUT': '86400', 08:22:11 INFO - 'USER': 'cltbld', 08:22:11 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1474901408.416707-68565470', 08:22:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:22:11 INFO - '_': '/tools/buildbot/bin/python'} 08:22:11 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/Pl5oGT5vQI2YLZqH_E7j4Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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 08:22:11 INFO - mozversion application_buildid: 20160926052750 08:22:11 INFO - mozversion application_changeset: e613221b195971a2b4a390bf6ca9109e09b99ddf 08:22:11 INFO - mozversion application_display_name: Firefox 08:22:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:22:11 INFO - mozversion application_name: Firefox 08:22:11 INFO - mozversion application_remotingname: firefox 08:22:11 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 08:22:11 INFO - mozversion application_vendor: Mozilla 08:22:11 INFO - mozversion application_version: 50.0 08:22:11 INFO - mozversion platform_buildid: 20160926052750 08:22:11 INFO - mozversion platform_changeset: e613221b195971a2b4a390bf6ca9109e09b99ddf 08:22:11 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 08:22:11 INFO - mozversion platform_version: 50.0 08:22:11 INFO - using testdate: 1474903331 08:22:11 INFO - actual date: 1474903331 08:22:11 INFO - starting webserver on 'localhost:47482' 08:22:11 INFO - SUITE-START | Running 2 tests 08:22:11 INFO - TEST-START | dromaeo_css 08:22:11 INFO - operating with platform_type : linux_ 08:22:11 INFO - Initialising browser for dromaeo_css test... 08:22:11 INFO - TEST-INFO | started process 4812 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXYbFxp/profile http://localhost:47482/getInfo.html) 08:22:16 INFO - PROCESS | 4812 | __metrics Screen width/height:1600/1200 08:22:16 INFO - PROCESS | 4812 | colorDepth:24 08:22:16 INFO - PROCESS | 4812 | Browser inner width/height: 1024/697 08:22:16 INFO - PROCESS | 4812 | __metrics 08:22:16 ERROR - PROCESS | 4812 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 08:22:17 INFO - TEST-INFO | 4812: exit 0 08:22:17 INFO - Browser initialized. 08:22:17 INFO - Running cycle 1/1 for dromaeo_css test... 08:22:17 INFO - TEST-INFO | started process 4934 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXYbFxp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:22:29 INFO - PROCESS | 4934 | RSS: Main: 149585920 08:22:29 INFO - PROCESS | 4934 | 08:23:19 INFO - PROCESS | 4934 | 1474903399046 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] 08:25:27 INFO - PROCESS | 4934 | Cycle 1(1): loaded http://localhost:47482/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47482/tests/dromaeo/cssquery-ext.html) 08:25:28 INFO - PROCESS | 4934 | RSS: Main: 158019584 08:25:28 INFO - PROCESS | 4934 | 08:28:30 INFO - PROCESS | 4934 | Cycle 1(1): loaded http://localhost:47482/tests/dromaeo/cssquery-ext.html (next: http://localhost:47482/tests/dromaeo/cssquery-jquery.html) 08:28:31 INFO - PROCESS | 4934 | RSS: Main: 155353088 08:28:31 INFO - PROCESS | 4934 | 08:31:32 INFO - PROCESS | 4934 | Cycle 1(1): loaded http://localhost:47482/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47482/tests/dromaeo/cssquery-mootools.html) 08:31:33 INFO - PROCESS | 4934 | RSS: Main: 154595328 08:31:33 INFO - PROCESS | 4934 | 08:34:35 INFO - PROCESS | 4934 | Cycle 1(1): loaded http://localhost:47482/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47482/tests/dromaeo/cssquery-prototype.html) 08:34:35 INFO - PROCESS | 4934 | RSS: Main: 156184576 08:34:35 INFO - PROCESS | 4934 | 08:37:38 INFO - PROCESS | 4934 | Cycle 1(1): loaded http://localhost:47482/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47482/tests/dromaeo/cssquery-yui.html) 08:37:38 INFO - PROCESS | 4934 | RSS: Main: 157421568 08:37:38 INFO - PROCESS | 4934 | 08:40:41 INFO - PROCESS | 4934 | Cycle 1(1): loaded http://localhost:47482/tests/dromaeo/cssquery-yui.html (next: http://localhost:47482/tests/dromaeo/cssquery-dojo.html) 08:40:41 INFO - PROCESS | 4934 | RSS: Main: 156930048 08:40:41 INFO - PROCESS | 4934 | 08:40:41 INFO - PROCESS | 4934 | __start_tp_report 08:40:41 INFO - PROCESS | 4934 | _x_x_mozilla_page_load 08:40:41 INFO - PROCESS | 4934 | _x_x_mozilla_page_load_details 08:40:41 INFO - PROCESS | 4934 | |i|pagename|runs| 08:40:41 INFO - PROCESS | 4934 | |0;dojo.html;3270.149761062124;3299.6370399256093;3304.801711897286;3319.0706602151404;3319.4356959316915;5703.515201207897;5797.739101740422;5808.2158908547335;5823.505002074829;5824.534037277013;5723.771049158028;5734.684592347419;5736.709240420903;5753.683547404891;5772.105323674827;5204.817831375903;5210.817621383252;5223.921641175385;5248.0553500369915;5250.7637156328055;5082.745862706868;5084.949150508503;5123.1546794778815;5130.769115389798;5205.557527610139;5123.795048198068;5150.124478838607;5161.76772045257;5171.689698618095;5193.065248255312;5184.11869982104;5225.4513276105845;5226.163813789775;5228.163493840986;5251.212318152269;4919.950800491985;4994.2508623706735;5024.874378140539;5099.15863882459;5103.591712662978;5582.609217354787;5616.9157462638095;5617.073182924853;5651;5702.429757024264;6013.579049466495;6031.065184896348;6048.758049678007;6067.453929146354;6074.969625151846;5891.79378721747;5972.492338151263;5992.310884248323;6063.605865618721;6157.2919114301985;5614.943850561483;5689.288838895138;5693.857653558694;5710.371859095496;5725.513331366838;6224.408681175281;6237.844053898689;6239.563230573816;6247.843803904939;6269.185005949197;5827.155062515912;5846.064629659234;5957.314908785458;5982.132590774313;6004.639721616717;5937.52499800015;6046.425589568984;6087.57386982907;6095.2685677718955;6106.053561697944;6028.5478589106;6039.758409663565;6040.577159598874;6045.063015232646;6064.999275119556;5834.474897259267;5949.9107513387335;5979.641221526722;6069.423404776539;6083.452489275898;4620.1221767864;4658.953410465852;4659.720416774937;4689.366935463669;4698.765061746899;4162.751174647594;4168.6665066794585;4171.0615111599645;4171.416001759756;4197.76912269822;5653.689047102449;5706.457886500859;5874.295084589877;5904.261967254093;5907.497862681635;6085.056816193497;6120.479759220427;6124.816255512342;6202.596831205957;6213.03697926822;5934.43622855828;5936.37668044849;5946.554008449383;5958.255218097738;5960.433758792908;5146.485351464824;5348.625596208228;5353.785848566014;5354.464553544614;5357.571394288448;6229.127922090911;6274.215723034621;6280.466160376419;6398.872022559616;6408.807735767934;6081.331053584191;6104.511639068953;6142.3550527194;6157.938420615916;6161.815145545641;6145.924463219008;6338.619682819046;6372.044193371032;6402.871942561216;6409;5940.673262970406;5980.790672326448;5985.581009329305;6041.6375017499095;6108;6139.140520327069;6160.630362178284;6161.322254552086;6182.659953702409;6191.566590338633;5799.101139323411;6030.819075427744;6039.245094363205;6054.182685337423;6065.757369705162;5898.469137777621;5932.822015339547;5962.493188079062;6031.457168854824;6065.969670151621;5946.762129514771;5979.521638269015;6005.549583781147;6018.849528761641;6021.849453763691;5910;5954.851128721643;6029.155918171372;6042.577019608585;6088.4824789893355;5794.304683438015;5837.0368889132815;5869.970650146722;5928.940710593011;5964.493018093337 08:40:41 INFO - PROCESS | 4934 | |1;ext.html;594.1473984831766;624.9593776404533;663.7046514301135;665.5075244319205;710.12299809735;42850;46706.53293467064;47176.29235561469;47332.29001564975;47406.52593474068;45951;46175.30737038947;46527.30209046867;46549.069018619695;46601;9117.316201284897;9224.907750922506;9239.02990186031;9244.399114057565;9249.075092490764;9156.633734650639;9194.58624361902;9235.584398702074;9235.630574777;9263.953680231589;9235.12266334697;9280.628774849032;9292.953535232315;9296;9300.441973481613;9137;9157.45055296681;9157.862632060524;9199.264058875275;9224.723258302261;9136.725898223063;9195.632174713004;9196.310276729271;9225.907740922572;9255.259579233712;45053;45453.09093818105;45690.77154614206;45701.77149114267;45721.31418028732;3567.8929632111076;3715.3312403767313;3766.6798322142376;3790.0903783092135;3940.389239667856;35508.822455887814;35776.28447431037;35994.8200258997;36004.63995360039;37599.24801503982;4807.807687692523;4845.355706697143;4875.609951203895;4954.975225123887;5091.338126043591;419658;419784;422049;423567.8821605903;425360;69407.65296173588;69562.3043769566;69812;69867.3013269871;69876;63884;69350;71416.28583714097;71875.2812471879;73241.6337918307;18180.818191818176;18407.447776566725;18444.170012349477;18447.446576602724;18520.351787687367;13951.511697090553;13961.79057314141;14055.22696251716;14135.363908624136;14150.150990940576;20728.689069663968;20833.89583052075;21110;21182.78817211839;21227.15091396327;7683.807904802313;7805.37556995439;7857.882131768028;7886.763397098096;7951.960240198878;1084.9349039057524;1096.9743290023853;1145.1525870855507;1157.3981529604728;1216.2216181643755;33554.32891342208;33941;33968.830155849064;33980.660193398246;33983.320333593685;1137.3744440557825;1151.9942400287946;1167.9708007299716;1189.5241903238773;1270.2632473165543;18012.639747204983;18059;18160.00119993413;18173.45479635613;18392.448226553224;154543;154585.22707386615;155517.2224138872;156408.2179589095;156624.2168789149;62287.688561556904;62699.68650156811;62787;62965;63004.68497657574;1431.7923901034292;1464.5459907428944;1468.6842328899338;1489.3372449259975;1500.482333594908;32697.509537356484;33525.66474335225;33529.66470335265;33627;33669.49495757517;53771;53973.73013134909;53977;53977.57100930389;54008;391340;392387;392829;393242;393250;30270.243243919078;31130.377392452476;31338.373232534766;31361.372772543964;31385;51525.48474515207;51549.226761599355;51636.48363516317;52129.47870521398;52219;43360;43729.56270437255;44498.77750611226;44633.55366446294;45567.088658227316;43912.780436097615;45045.32432013457;45903.31145032894;45985.540144598126;47065.764671176425;43414;44838.775806120764;45119.548804511534;46529.53470465387;48476.5152348472;40705;41280.79359603303;41504;42081.78959105307;42400;31141;31297;31382;31525.211869703442;31848.840755796075 08:40:41 INFO - PROCESS | 4934 | |2;jquery.html;428.9549597292282;429.7374373094699;434.37233198028844;438.44974556931055;449.05698034128335;19050.809491905078;20036.398908032763;20619.793802061973;20847.27034553791;20932.581348373024;19385.224591016377;19943.401697949048;20187.89906050468;20188.19247230109;20216.292429764962;5958.523318134549;6171.845703857417;6205.658688772116;6216.036514340262;6219.129321894939;6110.725017374229;6119.051547010221;6153.261608606974;6169.136320915076;6189.659568723719;6089.786857459968;6152.753889844401;6163.106349579309;6163.784267550636;6164.352742961992;6077.301110372319;6097.359777223394;6117.204763380754;6122.54080943931;6140.109684095826;5311.49540793624;5508.586855985817;5523.143912693539;5524.944750552523;5531.0873705838485;22961.196358127552;23973.76026239733;24070.51858962811;24175.153869614656;24882.253532394057;2521.0546045233036;2556.3992461771654;2866.570014497842;3154.369126174774;3161.9525707114412;11059.944700276528;11163.441827908571;11178.32930024193;11759.882401175964;14414.42342306317;1863.3292014874635;2003.268806885491;2013.1947221111527;2037.8675386100003;2060.9690854637192;81532;83838.58080709557;85442;85681.57159214227;86965.13034869697;11679.357635329969;11877.109216808774;12194.268343899394;12197.939010304892;12327.383630818602;16765.329386824633;16806.91596542034;16829.074400907823;16894.324227031026;16928.49214523566;8109.675612975533;8418.831623367621;8499.74500764978;8624.698135565224;8667.956660216658;7845.254700803414;7973.72091976778;8018.919810801817;8106.148854370206;8127.552984585786;5145.665531740425;5158.819441319536;5190.480951904855;5194.818181363634;5220.843374698765;2102.4113248290505;2182.127149140325;2196.417949243452;2205.3163519309064;2216.667499875032;955.2644463762864;986.1272773595276;987.3335498538457;994.7712026234007;1073.863012604926;21103.366898993056;21404.143834246766;21479.892600536896;21725.67411488829;21862.672059919114;1006.5118417567473;1050.5167622893402;1085.7122862441458;1090.0298734126634;1123.27548731068;11575.76848463026;11864.881351186377;11968.042556595452;12016.038716902627;12170.939145304394;494466;502691;503931;548053;576919;66947.66526167338;75092;98515.50742246243;99424;101008.49495752474;1102.9558817647364;1111.5998240633367;1130.2145009218514;1136.0627482327113;1140.9315441073395;18360;18670.906645466686;18963.810361896205;19068.523286917938;19174.233030679174;37699.43450848185;39482.2103557933;41856.79071604623;42198;43205.56794432015;54272;61693.691531542056;62596.374036259054;62679.686601566704;63736;8185.754427367188;8638.395312328077;8863.645454182019;9136.862947055932;9578.13796758295;13782.65543361424;14631;14853.851461485247;14898.851011489747;15380.846191538389;12411.317377544321;12572.736907356764;12596.370181490705;13114.344282785632;13260.801087983495;12233.531976162918;12381.00951923862;12611.36943152857;12702.67581816388;12762.48950042025;12116.21244619097;12635;12653.240805551697;12679.049071319872;13039.348032598142;8040.758777236459;8155.266026057683;8169.591520424074;8210;8434.746957591282;11084.61203857861;12244;12463.18989265731;12534.498620055096;12838.03714721381 08:40:41 INFO - PROCESS | 4934 | |3;mootools.html;1573.9291731872067;1574.9999999999995;1765.223301747232;1890.2439024390242;1912.6461604603157;8500.999999999984;9079.137481939222;9322.394044387127;9758.121769040785;9772.315937884343;9362.719118426441;9669.22646188305;9680.951595242013;9693.321467497279;9704.902950970489;2472.2830379190013;2523.3060908250195;2524.5708229601014;2526;2536.441982763789;2450.669159663449;2533.695956485215;2540.6697129373156;2544.1985774481072;2547;2493.1772515070074;2495.201535508638;2511.5981442969037;2527.36815796051;2528.2415275417393;2451.9264422067276;2454.840435371704;2465.938351541208;2471.95056098877;2488.1042824583137;2437.9756202437925;2440.2801173653816;2444.327809852287;2446.608542633188;2481.6525686403916;9934;9942.70171894837;9985.500724963722;10017.248706347053;10024.448655323955;5576.163575463673;5693.800716974886;5719.942800571983;5720.628159169641;5726.971365143189;3578.9284214315567;3662.6154253803234;3690.464882592036;3743.625637436262;3757.7933213673236;1132.0999805154922;1144.914131440137;1150.413289222494;1158.1140427572914;1200.837886885268;13673.316334183251;13674.179549227078;13719.862801371959;13720.588382348446;13727.725445491034;4884.9985752921275;4963.230699241623;5017.297578339036;5074.162763144113;5133.4096578893905;11577.552805899262;11606.187566870407;11622.535098595961;11662.591809286634;11690.240134391237;5746.454086861741;5760.913586296209;5786.450287222707;5804.6807425592;5805.390434004453;4694.765261736899;5119.155339368963;5222.608304377187;5244.711540865213;5341.599380046512;4349.652027837766;4412.713173643703;4472.731636101845;4482.5069242383315;4499.0776890737325;1341.9731605367838;1352.3238380809596;1370.0615078671142;1370.328539015875;1401.5585090696397;938.3244064273712;1035.7928414317166;1070.834020726773;1075.4031512510633;1088.8747794003632;6556.606603603704;6566.770163044271;6724.831879203059;6810.523263371517;6849.931500685029;471.9098881583553;480.9158397280462;1083.967480975572;1121.7027487715761;1131.6322195286564;4393.0994146199955;4532.229520981441;4573.885652858638;4582.083583283356;4612.446506419251;11386.94306528462;11647.941760291314;12228.449719762632;12674.619761407173;12707.174033687781;11741.119416043832;11804.70488237801;11900.940495297642;11911.761764764657;11988.580399685969;8770;9040.773980650536;9087.000429952699;9095.727128186165;9099.954500227457;6901.896471553031;7087.893681594884;7107.857842843217;7116.25279345682;7155.8568828624175;11179;11313.604023859125;11616.535338586362;11690.649280521598;11711.472983715583;11515.424228788695;11697;11716.355600442057;11747.118966077407;11787.233829801036;8476.703315383931;8715.564221788758;8771.035186129393;8795.956020219857;8881.822363552821;9632.75918102025;9717.708468745948;9727.805443891224;9750.75623109428;9755.658551950648;8522.36082293818;8653.870191947251;8677.6095075723;8723.781905452415;8770.693025744069;8505.23452889243;8510.106438823834;8579.82840343202;8726.171013753683;8749.781255468664;7086.681099350645;7206.927930720625;7229.819254518468;7231.63841807897;7243.348098671145;5517.5585953124455;5539.916901246565;5614.803481878114;5746.597738158289;5863.120531920075;5679.204911312502;5742.16738572913;5807.912881306699;5849.590528662953;5873.236479257669 08:40:41 INFO - PROCESS | 4934 | |4;prototype.html;345.123386598041;347.7461453139208;348.3781450111551;355.58574260985955;355.7563069297533;5789.639434732834;5810.680412577307;5814.127880817874;5843.532517398608;5881.206621728982;5726.770929162839;5741.540676745861;5756.683382413966;5760.193572899798;5766.961946849566;4064;4446.933296000562;4477.888052798674;4496.875781054737;4511.458624965009;4465.397171381855;4473.66447516436;4474.843380481684;4493.662975276868;4503.57216064475;4426.867193984185;4480.6191473724775;4481;4485.798139083749;4493.505714371417;4343.761093139892;4454.460957254366;4462.486814016397;4480.014396832692;4483.663725220622;3963.7027222958395;3967.920641587152;3973.6821054315587;3985.8405663773415;3987.6610488108545;5508;5523.420040895729;5547.694876781776;5566.332040155166;5599.468050535193;5000.922955653209;5116.897662046738;5156.303898973628;5163.173892177234;5167.199084141964;5963.314218864843;5964.075568286922;5966.791162309299;5980.312264089598;5986.820395388146;4296.312589985588;4369.104333611602;4380.802863871133;4388.210122178007;4399.73601583906;6189.3907584028475;6222.906656400158;6252.81151596942;6265.7493700251935;6277.309495955441;4465.799039043186;4476.127155204769;4482.551744825491;4484.394606728115;4492.124035812985;4399.406080179135;4539.84110556129;4550;4556.749378784199;4562.817487300537;5112.667676601009;5118.436971933084;5145.665531740425;5160.638755287094;5165.328507294028;6077.24034495688;6107.603005804608;6108.625559249133;6112.694365281718;6113.84715382119;1475.2844870237925;1538.715337662536;1563.6481791597027;1583.5328578069498;1590.8965917215344;969.5588507229194;971.5725080964494;1012.9088382045651;1040.458961340099;1057.2282233969245;5808.680522571215;5850.1224816277045;5855.677937713466;5859.853503662357;5904.752386187665;6102.450779429784;6166.537509686702;6180.381961803873;6203.751849925952;6218.81343559694;5771.480566748929;5779.537636989115;5816.272965879265;5832.679202643895;5889.55705852069;3247.626522949891;3277.754168437377;3288.753343499247;3290.5393244945726;3297.3240485700376;6112.724927378279;6347.365263473615;6397.904031439532;6402.423781859655;6427.164468619143;6178.814635560941;6210.31686514483;6234.220722409699;6248.781292654826;6253.530420351214;6153.661548614779;6328.525360597973;6331.366863313632;6341.619502829845;6349.460295874902;6081.331053584191;6107.725152368065;6116.480099191618;6118.326984031842;6144.293406258337;5920.585559010828;5968.16445697594;5971.402859713994;5972.70136493165;5995.280566332068;6068.302145253352;6305.621662700252;6331.778387756406;6338.746450142127;6338.968305158444;4345.022369966732;4370.147821174841;4373.278409062469;4375.8030888609455;4387.319965405367;5992.43071908168;6122.326544080059;6132.558848670648;6132.846678833065;6154.261488621394;5954.791582294599;5963.821085367446;5967.224260846062;5972.671503067373;5991.101334799815;5947.256592925884;5980;6001.789937352171;6003.129546215687;6006.579539432198;5791.478766910998;5846;5930.881382372242;5948.256467941507;6108.4807791338235;6150.138980542638;6156.692165391623;6158.846028849135;6166.876662466815;6199.814005579839;5911.822645320647;6015.248093988252;6020.518358531394;6025.6083354581815;6027.126066720389 08:40:41 INFO - PROCESS | 4934 | |5;yui.html;697.3166297028909;706.2725392845371;732.4433430592751;780.7813812132603;838.8322335532891;13517.391717372717;14429.350679219435;14487.565373038826;14536.709265814678;14558.636034099152;14339.498117565887;14505.202213878232;14558.636034099152;14603.123812571253;14948.551543453686;874.7026011156206;901.9368644194909;911.8814554107956;913.5706218077493;914.9039350868163;852.2244757270885;884.0893879304327;890.2877697841733;904.7421484876811;906.2432868554764;948.3266880514843;950.9381890177151;953.0374321934827;953.046953046953;953.6948176583496;949.093615597103;949.5394733554186;949.8052899155656;950.12588418655;950.7432993091861;693.7086423702058;696.5646470955653;698.3609996852924;699.4579201119122;700.6216643012767;13995.37020834065;14028;14111.717765644733;14235.644108897257;14288.928555357157;14701.1914344711;14794.112353258839;14998.850011499855;15010.324535395825;15121.848781512153;12707.428165732565;13082.934585327108;13183.538576149884;13350.732985340239;13486.325683715873;4019.7588144711412;4091.1204091120553;4103.9179216415505;4126.8761937141935;4210.831566737357;70902;81091.59454202751;81964;84037.15962840416;84289;11655.76688466226;12180.695482613006;12215.816762748565;12372.62882113538;12423.565175218824;21480.785192148192;21660.891695541737;21860.234891778713;22019.779802201774;22268.331950041524;8069.6368663410285;8604.784880377916;8785.780355491164;8853.645854165761;8911.108889111038;5070.442251352349;5127.717975511383;5204.531592156724;5260.158374660036;5283.2075188722;3716.0709822544363;3839.347310957144;3839.5968423315708;3840.1551658635058;3843.6540711336115;678.7556479667315;688.9345512176335;697.9232284448707;708.4969671533269;709.8935159726083;774.5662429039643;798.5408390175556;814.5967745965785;831.5343407691712;832.4838600067876;10646.733831654115;11021.393823339793;11069.50187241576;11173.608923687794;11601.12991525639;681.6319187638719;776.281939206232;825.4345773145415;827.0571548434789;873.4409977614332;4985.501449854985;5171.715555644476;5201.167813149954;5236.136037553837;5240.3973543042275;71222.64388678024;71252.28747712457;72765.6361718188;72766;73544.26455735374;106942;107188;109121.45439272912;109528;112331.4383428094;94671;97426;97845;97854.5107274459;101100.49449752852;9887.851682224917;10539.367637941748;10633.521491532745;10663.89336106629;10682;46408.76795616;51909;52542.73728631332;53032.734836327116;53110;76660;77079;79725;80410.5979470099;81258.59370703109;13684.589462316146;13704.862951370358;13963.232022238875;14237.21695306768;14424.350904209126;14634.853651463349;14739.92630036843;15114.09315441077;15927.920360398124;16459.25933332979;14685.265736712909;15019.474318398803;15349.309281082154;15379.307931142901;15669.138197399252;14279.857201428269;15210.46763363277;15277.77083343773;15474.690506190038;15535;13308.667283317607;13526.79709804334;13575.592732218049;13635.181889086687;14080.36638351256;11465.541378345106;11542.538298467967;11807.586734464596;11967.581134660246;12353.3823308836;11166.665000050012;11514.76970460603;11533.365664888512;11677.941610291895;11689.298642081503 08:40:41 INFO - PROCESS | 4934 | __end_tp_report 08:40:41 INFO - PROCESS | 4934 | __start_cc_report 08:40:41 INFO - PROCESS | 4934 | _x_x_mozilla_cycle_collect,322 08:40:41 INFO - PROCESS | 4934 | __end_cc_report 08:40:41 INFO - PROCESS | 4934 | __startTimestamp1474904441443__endTimestamp 08:40:41 INFO - PROCESS | 4934 | 08:40:41 INFO - PROCESS | 4934 | ------- Summary: start ------- 08:40:41 INFO - PROCESS | 4934 | Number of tests: 6 08:40:41 INFO - PROCESS | 4934 | 08:40:41 INFO - PROCESS | 4934 | [#0] dojo.html Cycles:165 Average:5669.92 Median:5934.44 stddev:647.09 (10.9%) stddev-sans-first:621.08 08:40:41 INFO - PROCESS | 4934 | Values: 3270.1 3299.6 3304.8 3319.1 3319.4 5703.5 5797.7 5808.2 5823.5 5824.5 5723.8 5734.7 5736.7 5753.7 5772.1 5204.8 5210.8 5223.9 5248.1 5250.8 5082.7 5084.9 5123.2 5130.8 5205.6 5123.8 5150.1 5161.8 5171.7 5193.1 5184.1 5225.5 5226.2 5228.2 5251.2 4920.0 4994.3 5024.9 5099.2 5103.6 5582.6 5616.9 5617.1 5651.0 5702.4 6013.6 6031.1 6048.8 6067.5 6075.0 5891.8 5972.5 5992.3 6063.6 6157.3 5614.9 5689.3 5693.9 5710.4 5725.5 6224.4 6237.8 6239.6 6247.8 6269.2 5827.2 5846.1 5957.3 5982.1 6004.6 5937.5 6046.4 6087.6 6095.3 6106.1 6028.5 6039.8 6040.6 6045.1 6065.0 5834.5 5949.9 5979.6 6069.4 6083.5 4620.1 4659.0 4659.7 4689.4 4698.8 4162.8 4168.7 4171.1 4171.4 4197.8 5653.7 5706.5 5874.3 5904.3 5907.5 6085.1 6120.5 6124.8 6202.6 6213.0 5934.4 5936.4 5946.6 5958.3 5960.4 5146.5 5348.6 5353.8 5354.5 5357.6 6229.1 6274.2 6280.5 6398.9 6408.8 6081.3 6104.5 6142.4 6157.9 6161.8 6145.9 6338.6 6372.0 6402.9 6409.0 5940.7 5980.8 5985.6 6041.6 6108.0 6139.1 6160.6 6161.3 6182.7 6191.6 5799.1 6030.8 6039.2 6054.2 6065.8 5898.5 5932.8 5962.5 6031.5 6066.0 5946.8 5979.5 6005.5 6018.8 6021.8 5910.0 5954.9 6029.2 6042.6 6088.5 5794.3 5837.0 5870.0 5928.9 5964.5 08:40:41 INFO - PROCESS | 4934 | 08:40:41 INFO - PROCESS | 4934 | [#1] ext.html Cycles:180 Average:52734.97 Median:44566.17 stddev:91125.16 (204.5%) stddev-sans-first:91296.69 08:40:41 INFO - PROCESS | 4934 | Values: 594.1 625.0 663.7 665.5 710.1 42850.0 46706.5 47176.3 47332.3 47406.5 45951.0 46175.3 46527.3 46549.1 46601.0 9117.3 9224.9 9239.0 9244.4 9249.1 9156.6 9194.6 9235.6 9235.6 9264.0 9235.1 9280.6 9293.0 9296.0 9300.4 9137.0 9157.5 9157.9 9199.3 9224.7 9136.7 9195.6 9196.3 9225.9 9255.3 45053.0 45453.1 45690.8 45701.8 45721.3 3567.9 3715.3 3766.7 3790.1 3940.4 35508.8 35776.3 35994.8 36004.6 37599.2 4807.8 4845.4 4875.6 4955.0 5091.3 419658.0 419784.0 422049.0 423567.9 425360.0 69407.7 69562.3 69812.0 69867.3 69876.0 63884.0 69350.0 71416.3 71875.3 73241.6 18180.8 18407.4 18444.2 18447.4 18520.4 13951.5 13961.8 14055.2 14135.4 14150.2 20728.7 20833.9 21110.0 21182.8 21227.2 7683.8 7805.4 7857.9 7886.8 7952.0 1084.9 1097.0 1145.2 1157.4 1216.2 33554.3 33941.0 33968.8 33980.7 33983.3 1137.4 1152.0 1168.0 1189.5 1270.3 18012.6 18059.0 18160.0 18173.5 18392.4 154543.0 154585.2 155517.2 156408.2 156624.2 62287.7 62699.7 62787.0 62965.0 63004.7 1431.8 1464.5 1468.7 1489.3 1500.5 32697.5 33525.7 33529.7 33627.0 33669.5 53771.0 53973.7 53977.0 53977.6 54008.0 391340.0 392387.0 392829.0 393242.0 393250.0 30270.2 31130.4 31338.4 31361.4 31385.0 51525.5 51549.2 51636.5 52129.5 52219.0 43360.0 43729.6 44498.8 44633.6 45567.1 43912.8 45045.3 45903.3 45985.5 47065.8 43414.0 44838.8 45119.5 46529.5 48476.5 40705.0 41280.8 41504.0 42081.8 42400.0 31141.0 31297.0 31382.0 31525.2 31848.8 08:40:41 INFO - PROCESS | 4934 | 08:40:41 INFO - PROCESS | 4934 | [#2] jquery.html Cycles:180 Average:30603.21 Median:24528.70 stddev:86521.63 (352.7%) stddev-sans-first:86734.68 08:40:41 INFO - PROCESS | 4934 | Values: 429.0 429.7 434.4 438.4 449.1 19050.8 20036.4 20619.8 20847.3 20932.6 19385.2 19943.4 20187.9 20188.2 20216.3 5958.5 6171.8 6205.7 6216.0 6219.1 6110.7 6119.1 6153.3 6169.1 6189.7 6089.8 6152.8 6163.1 6163.8 6164.4 6077.3 6097.4 6117.2 6122.5 6140.1 5311.5 5508.6 5523.1 5524.9 5531.1 22961.2 23973.8 24070.5 24175.2 24882.3 2521.1 2556.4 2866.6 3154.4 3162.0 11059.9 11163.4 11178.3 11759.9 14414.4 1863.3 2003.3 2013.2 2037.9 2061.0 81532.0 83838.6 85442.0 85681.6 86965.1 11679.4 11877.1 12194.3 12197.9 12327.4 16765.3 16806.9 16829.1 16894.3 16928.5 8109.7 8418.8 8499.7 8624.7 8668.0 7845.3 7973.7 8018.9 8106.1 8127.6 5145.7 5158.8 5190.5 5194.8 5220.8 2102.4 2182.1 2196.4 2205.3 2216.7 955.3 986.1 987.3 994.8 1073.9 21103.4 21404.1 21479.9 21725.7 21862.7 1006.5 1050.5 1085.7 1090.0 1123.3 11575.8 11864.9 11968.0 12016.0 12170.9 494466.0 502691.0 503931.0 548053.0 576919.0 66947.7 75092.0 98515.5 99424.0 101008.5 1103.0 1111.6 1130.2 1136.1 1140.9 18360.0 18670.9 18963.8 19068.5 19174.2 37699.4 39482.2 41856.8 42198.0 43205.6 54272.0 61693.7 62596.4 62679.7 63736.0 8185.8 8638.4 8863.6 9136.9 9578.1 13782.7 14631.0 14853.9 14898.9 15380.8 12411.3 12572.7 12596.4 13114.3 13260.8 12233.5 12381.0 12611.4 12702.7 12762.5 12116.2 12635.0 12653.2 12679.0 13039.3 8040.8 8155.3 8169.6 8210.0 8434.7 11084.6 12244.0 12463.2 12534.5 12838.0 08:40:41 INFO - PROCESS | 4934 | 08:40:41 INFO - PROCESS | 4934 | [#3] mootools.html Cycles:180 Average:6430.54 Median:4553.06 stddev:3717.14 (81.6%) stddev-sans-first:3709.65 08:40:41 INFO - PROCESS | 4934 | Values: 1573.9 1575.0 1765.2 1890.2 1912.6 8501.0 9079.1 9322.4 9758.1 9772.3 9362.7 9669.2 9681.0 9693.3 9704.9 2472.3 2523.3 2524.6 2526.0 2536.4 2450.7 2533.7 2540.7 2544.2 2547.0 2493.2 2495.2 2511.6 2527.4 2528.2 2451.9 2454.8 2465.9 2472.0 2488.1 2438.0 2440.3 2444.3 2446.6 2481.7 9934.0 9942.7 9985.5 10017.2 10024.4 5576.2 5693.8 5719.9 5720.6 5727.0 3578.9 3662.6 3690.5 3743.6 3757.8 1132.1 1144.9 1150.4 1158.1 1200.8 13673.3 13674.2 13719.9 13720.6 13727.7 4885.0 4963.2 5017.3 5074.2 5133.4 11577.6 11606.2 11622.5 11662.6 11690.2 5746.5 5760.9 5786.5 5804.7 5805.4 4694.8 5119.2 5222.6 5244.7 5341.6 4349.7 4412.7 4472.7 4482.5 4499.1 1342.0 1352.3 1370.1 1370.3 1401.6 938.3 1035.8 1070.8 1075.4 1088.9 6556.6 6566.8 6724.8 6810.5 6849.9 471.9 480.9 1084.0 1121.7 1131.6 4393.1 4532.2 4573.9 4582.1 4612.4 11386.9 11647.9 12228.4 12674.6 12707.2 11741.1 11804.7 11900.9 11911.8 11988.6 8770.0 9040.8 9087.0 9095.7 9100.0 6901.9 7087.9 7107.9 7116.3 7155.9 11179.0 11313.6 11616.5 11690.6 11711.5 11515.4 11697.0 11716.4 11747.1 11787.2 8476.7 8715.6 8771.0 8796.0 8881.8 9632.8 9717.7 9727.8 9750.8 9755.7 8522.4 8653.9 8677.6 8723.8 8770.7 8505.2 8510.1 8579.8 8726.2 8749.8 7086.7 7206.9 7229.8 7231.6 7243.3 5517.6 5539.9 5614.8 5746.6 5863.1 5679.2 5742.2 5807.9 5849.6 5873.2 08:40:41 INFO - PROCESS | 4934 | 08:40:41 INFO - PROCESS | 4934 | [#4] prototype.html Cycles:180 Average:5073.25 Median:5824.48 stddev:1486.19 (25.5%) stddev-sans-first:1447.37 08:40:41 INFO - PROCESS | 4934 | Values: 345.1 347.7 348.4 355.6 355.8 5789.6 5810.7 5814.1 5843.5 5881.2 5726.8 5741.5 5756.7 5760.2 5767.0 4064.0 4446.9 4477.9 4496.9 4511.5 4465.4 4473.7 4474.8 4493.7 4503.6 4426.9 4480.6 4481.0 4485.8 4493.5 4343.8 4454.5 4462.5 4480.0 4483.7 3963.7 3967.9 3973.7 3985.8 3987.7 5508.0 5523.4 5547.7 5566.3 5599.5 5000.9 5116.9 5156.3 5163.2 5167.2 5963.3 5964.1 5966.8 5980.3 5986.8 4296.3 4369.1 4380.8 4388.2 4399.7 6189.4 6222.9 6252.8 6265.7 6277.3 4465.8 4476.1 4482.6 4484.4 4492.1 4399.4 4539.8 4550.0 4556.7 4562.8 5112.7 5118.4 5145.7 5160.6 5165.3 6077.2 6107.6 6108.6 6112.7 6113.8 1475.3 1538.7 1563.6 1583.5 1590.9 969.6 971.6 1012.9 1040.5 1057.2 5808.7 5850.1 5855.7 5859.9 5904.8 6102.5 6166.5 6180.4 6203.8 6218.8 5771.5 5779.5 5816.3 5832.7 5889.6 3247.6 3277.8 3288.8 3290.5 3297.3 6112.7 6347.4 6397.9 6402.4 6427.2 6178.8 6210.3 6234.2 6248.8 6253.5 6153.7 6328.5 6331.4 6341.6 6349.5 6081.3 6107.7 6116.5 6118.3 6144.3 5920.6 5968.2 5971.4 5972.7 5995.3 6068.3 6305.6 6331.8 6338.7 6339.0 4345.0 4370.1 4373.3 4375.8 4387.3 5992.4 6122.3 6132.6 6132.8 6154.3 5954.8 5963.8 5967.2 5972.7 5991.1 5947.3 5980.0 6001.8 6003.1 6006.6 5791.5 5846.0 5930.9 5948.3 6108.5 6150.1 6156.7 6158.8 6166.9 6199.8 5911.8 6015.2 6020.5 6025.6 6027.1 08:40:41 INFO - PROCESS | 4934 | 08:40:41 INFO - PROCESS | 4934 | [#5] yui.html Cycles:180 Average:20772.77 Median:4055.44 stddev:28917.48 (713.1%) stddev-sans-first:28959.31 08:40:41 INFO - PROCESS | 4934 | Values: 697.3 706.3 732.4 780.8 838.8 13517.4 14429.4 14487.6 14536.7 14558.6 14339.5 14505.2 14558.6 14603.1 14948.6 874.7 901.9 911.9 913.6 914.9 852.2 884.1 890.3 904.7 906.2 948.3 950.9 953.0 953.0 953.7 949.1 949.5 949.8 950.1 950.7 693.7 696.6 698.4 699.5 700.6 13995.4 14028.0 14111.7 14235.6 14288.9 14701.2 14794.1 14998.9 15010.3 15121.8 12707.4 13082.9 13183.5 13350.7 13486.3 4019.8 4091.1 4103.9 4126.9 4210.8 70902.0 81091.6 81964.0 84037.2 84289.0 11655.8 12180.7 12215.8 12372.6 12423.6 21480.8 21660.9 21860.2 22019.8 22268.3 8069.6 8604.8 8785.8 8853.6 8911.1 5070.4 5127.7 5204.5 5260.2 5283.2 3716.1 3839.3 3839.6 3840.2 3843.7 678.8 688.9 697.9 708.5 709.9 774.6 798.5 814.6 831.5 832.5 10646.7 11021.4 11069.5 11173.6 11601.1 681.6 776.3 825.4 827.1 873.4 4985.5 5171.7 5201.2 5236.1 5240.4 71222.6 71252.3 72765.6 72766.0 73544.3 106942.0 107188.0 109121.5 109528.0 112331.4 94671.0 97426.0 97845.0 97854.5 101100.5 9887.9 10539.4 10633.5 10663.9 10682.0 46408.8 51909.0 52542.7 53032.7 53110.0 76660.0 77079.0 79725.0 80410.6 81258.6 13684.6 13704.9 13963.2 14237.2 14424.4 14634.9 14739.9 15114.1 15927.9 16459.3 14685.3 15019.5 15349.3 15379.3 15669.1 14279.9 15210.5 15277.8 15474.7 15535.0 13308.7 13526.8 13575.6 13635.2 14080.4 11465.5 11542.5 11807.6 11967.6 12353.4 11166.7 11514.8 11533.4 11677.9 11689.3 08:40:41 INFO - PROCESS | 4934 | -------- Summary: end -------- 08:40:41 INFO - PROCESS | 4934 | 08:40:42 INFO - TEST-INFO | 4934: exit 0 08:40:42 INFO - TEST-OK | dromaeo_css | took 1110192ms 08:40:42 INFO - TEST-START | kraken 08:40:42 INFO - operating with platform_type : linux_ 08:40:42 INFO - Initialising browser for kraken test... 08:40:42 INFO - TEST-INFO | started process 5175 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp57w5t7/profile http://localhost:47482/getInfo.html) 08:40:46 INFO - PROCESS | 5175 | __metrics Screen width/height:1600/1200 08:40:46 INFO - PROCESS | 5175 | colorDepth:24 08:40:46 INFO - PROCESS | 5175 | Browser inner width/height: 1024/697 08:40:46 INFO - PROCESS | 5175 | __metrics 08:40:47 ERROR - PROCESS | 5175 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 08:40:47 INFO - TEST-INFO | 5175: exit 0 08:40:47 INFO - Browser initialized. 08:40:47 INFO - Running cycle 1/1 for kraken test... 08:40:47 INFO - TEST-INFO | started process 5300 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp57w5t7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:40:59 INFO - PROCESS | 5300 | RSS: Main: 149856256 08:40:59 INFO - PROCESS | 5300 | 08:41:02 INFO - PROCESS | 5300 | Cycle 1(1): loaded http://localhost:47482/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47482/tests/kraken/driver.html?testName=audio-beat-detection) 08:41:02 INFO - PROCESS | 5300 | RSS: Main: 156676096 08:41:02 INFO - PROCESS | 5300 | 08:41:05 INFO - PROCESS | 5300 | Cycle 1(1): loaded http://localhost:47482/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47482/tests/kraken/driver.html?testName=audio-dft) 08:41:06 INFO - PROCESS | 5300 | RSS: Main: 155402240 08:41:06 INFO - PROCESS | 5300 | 08:41:08 INFO - PROCESS | 5300 | Cycle 1(1): loaded http://localhost:47482/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47482/tests/kraken/driver.html?testName=audio-fft) 08:41:09 INFO - PROCESS | 5300 | RSS: Main: 155983872 08:41:09 INFO - PROCESS | 5300 | 08:41:11 INFO - PROCESS | 5300 | Cycle 1(1): loaded http://localhost:47482/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47482/tests/kraken/driver.html?testName=audio-oscillator) 08:41:12 INFO - PROCESS | 5300 | RSS: Main: 156303360 08:41:12 INFO - PROCESS | 5300 | 08:41:14 INFO - PROCESS | 5300 | Cycle 1(1): loaded http://localhost:47482/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47482/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:41:15 INFO - PROCESS | 5300 | RSS: Main: 155594752 08:41:15 INFO - PROCESS | 5300 | 08:41:18 INFO - PROCESS | 5300 | Cycle 1(1): loaded http://localhost:47482/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47482/tests/kraken/driver.html?testName=imaging-darkroom) 08:41:18 INFO - PROCESS | 5300 | RSS: Main: 155680768 08:41:18 INFO - PROCESS | 5300 | 08:41:22 INFO - PROCESS | 5300 | Cycle 1(1): loaded http://localhost:47482/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47482/tests/kraken/driver.html?testName=imaging-desaturate) 08:41:22 INFO - PROCESS | 5300 | RSS: Main: 156397568 08:41:22 INFO - PROCESS | 5300 | 08:41:25 INFO - PROCESS | 5300 | Cycle 1(1): loaded http://localhost:47482/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47482/tests/kraken/driver.html?testName=json-parse-financial) 08:41:26 INFO - PROCESS | 5300 | RSS: Main: 156168192 08:41:26 INFO - PROCESS | 5300 | 08:41:27 INFO - PROCESS | 5300 | Cycle 1(1): loaded http://localhost:47482/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47482/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:41:28 INFO - PROCESS | 5300 | RSS: Main: 154902528 08:41:28 INFO - PROCESS | 5300 | 08:41:30 INFO - PROCESS | 5300 | Cycle 1(1): loaded http://localhost:47482/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47482/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:41:30 INFO - PROCESS | 5300 | RSS: Main: 156127232 08:41:30 INFO - PROCESS | 5300 | 08:41:32 INFO - PROCESS | 5300 | Cycle 1(1): loaded http://localhost:47482/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47482/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:41:33 INFO - PROCESS | 5300 | RSS: Main: 155774976 08:41:33 INFO - PROCESS | 5300 | 08:41:35 INFO - PROCESS | 5300 | Cycle 1(1): loaded http://localhost:47482/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47482/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:41:36 INFO - PROCESS | 5300 | RSS: Main: 155996160 08:41:36 INFO - PROCESS | 5300 | 08:41:39 INFO - PROCESS | 5300 | Cycle 1(1): loaded http://localhost:47482/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47482/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:41:39 INFO - PROCESS | 5300 | RSS: Main: 157241344 08:41:39 INFO - PROCESS | 5300 | 08:41:41 INFO - PROCESS | 5300 | Cycle 1(1): loaded http://localhost:47482/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47482/tests/kraken/driver.html?testName=ai-astar) 08:41:41 INFO - PROCESS | 5300 | RSS: Main: 158814208 08:41:41 INFO - PROCESS | 5300 | 08:41:41 INFO - PROCESS | 5300 | __start_tp_report 08:41:41 INFO - PROCESS | 5300 | _x_x_mozilla_page_load 08:41:41 INFO - PROCESS | 5300 | _x_x_mozilla_page_load_details 08:41:41 INFO - PROCESS | 5300 | |i|pagename|runs| 08:41:41 INFO - PROCESS | 5300 | |0;ai-astar;103;112;107;111;114;110;110;112;112;113 08:41:41 INFO - PROCESS | 5300 | |1;audio-beat-detection;138;115;146;169;118;147;147;117;170;116 08:41:41 INFO - PROCESS | 5300 | |2;audio-dft;163;162;161;161;163;161;163;160;161;160 08:41:41 INFO - PROCESS | 5300 | |3;audio-fft;73;75;75;175;75;77;74;74;168;74 08:41:41 INFO - PROCESS | 5300 | |4;audio-oscillator;83;82;141;84;83;83;149;83;83;142 08:41:41 INFO - PROCESS | 5300 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;118 08:41:41 INFO - PROCESS | 5300 | |6;imaging-darkroom;145;148;146;148;147;146;148;147;146;146 08:41:41 INFO - PROCESS | 5300 | |7;imaging-desaturate;96;95;96;95;95;95;95;95;95;95 08:41:41 INFO - PROCESS | 5300 | |8;json-parse-financial;55;51;55;52;51;55;55;52;53;51 08:41:41 INFO - PROCESS | 5300 | |9;json-stringify-tinderbox;60;59;59;59;60;59;59;60;63;59 08:41:41 INFO - PROCESS | 5300 | |10;stanford-crypto-aes;72;73;73;81;72;72;74;76;76;72 08:41:41 INFO - PROCESS | 5300 | |11;stanford-crypto-ccm;117;116;118;135;131;120;116;129;163;117 08:41:41 INFO - PROCESS | 5300 | |12;stanford-crypto-pbkdf2;151;155;152;150;153;148;154;155;150;151 08:41:41 INFO - PROCESS | 5300 | |13;stanford-crypto-sha256-iterative;61;65;61;61;62;60;64;62;61;61 08:41:41 INFO - PROCESS | 5300 | __end_tp_report 08:41:41 INFO - PROCESS | 5300 | __start_cc_report 08:41:41 INFO - PROCESS | 5300 | _x_x_mozilla_cycle_collect,836 08:41:41 INFO - PROCESS | 5300 | __end_cc_report 08:41:41 INFO - PROCESS | 5300 | __startTimestamp1474904501588__endTimestamp 08:41:41 INFO - PROCESS | 5300 | 08:41:41 INFO - PROCESS | 5300 | ------- Summary: start ------- 08:41:41 INFO - PROCESS | 5300 | Number of tests: 14 08:41:41 INFO - PROCESS | 5300 | 08:41:41 INFO - PROCESS | 5300 | [#0] ai-astar Cycles:10 Average:110.40 Median:112.00 stddev:3.24 (2.9%) stddev-sans-first:2.05 08:41:41 INFO - PROCESS | 5300 | Values: 103.0 112.0 107.0 111.0 114.0 110.0 110.0 112.0 112.0 113.0 08:41:41 INFO - PROCESS | 5300 | 08:41:41 INFO - PROCESS | 5300 | [#1] audio-beat-detection Cycles:10 Average:138.30 Median:146.50 stddev:21.25 (14.5%) stddev-sans-first:22.54 08:41:41 INFO - PROCESS | 5300 | Values: 138.0 115.0 146.0 169.0 118.0 147.0 147.0 117.0 170.0 116.0 08:41:41 INFO - PROCESS | 5300 | 08:41:41 INFO - PROCESS | 5300 | [#2] audio-dft Cycles:10 Average:161.50 Median:161.50 stddev:1.18 (0.7%) stddev-sans-first:1.12 08:41:41 INFO - PROCESS | 5300 | Values: 163.0 162.0 161.0 161.0 163.0 161.0 163.0 160.0 161.0 160.0 08:41:41 INFO - PROCESS | 5300 | 08:41:41 INFO - PROCESS | 5300 | [#3] audio-fft Cycles:10 Average:94.00 Median:74.50 stddev:40.89 (54.9%) stddev-sans-first:42.66 08:41:41 INFO - PROCESS | 5300 | Values: 73.0 75.0 75.0 175.0 75.0 77.0 74.0 74.0 168.0 74.0 08:41:41 INFO - PROCESS | 5300 | 08:41:41 INFO - PROCESS | 5300 | [#4] audio-oscillator Cycles:10 Average:101.30 Median:83.00 stddev:29.54 (35.6%) stddev-sans-first:30.58 08:41:41 INFO - PROCESS | 5300 | Values: 83.0 82.0 141.0 84.0 83.0 83.0 149.0 83.0 83.0 142.0 08:41:41 INFO - PROCESS | 5300 | 08:41:41 INFO - PROCESS | 5300 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 08:41:41 INFO - PROCESS | 5300 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 08:41:41 INFO - PROCESS | 5300 | 08:41:41 INFO - PROCESS | 5300 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:1.06 (0.7%) stddev-sans-first:0.93 08:41:41 INFO - PROCESS | 5300 | Values: 145.0 148.0 146.0 148.0 147.0 146.0 148.0 147.0 146.0 146.0 08:41:41 INFO - PROCESS | 5300 | 08:41:41 INFO - PROCESS | 5300 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 08:41:41 INFO - PROCESS | 5300 | Values: 96.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 08:41:41 INFO - PROCESS | 5300 | 08:41:41 INFO - PROCESS | 5300 | [#8] json-parse-financial Cycles:10 Average:53.00 Median:54.00 stddev:1.83 (3.4%) stddev-sans-first:1.79 08:41:41 INFO - PROCESS | 5300 | Values: 55.0 51.0 55.0 52.0 51.0 55.0 55.0 52.0 53.0 51.0 08:41:41 INFO - PROCESS | 5300 | 08:41:41 INFO - PROCESS | 5300 | [#9] json-stringify-tinderbox Cycles:10 Average:59.70 Median:59.50 stddev:1.25 (2.1%) stddev-sans-first:1.32 08:41:41 INFO - PROCESS | 5300 | Values: 60.0 59.0 59.0 59.0 60.0 59.0 59.0 60.0 63.0 59.0 08:41:41 INFO - PROCESS | 5300 | 08:41:41 INFO - PROCESS | 5300 | [#10] stanford-crypto-aes Cycles:10 Average:74.10 Median:73.50 stddev:2.88 (3.9%) stddev-sans-first:2.96 08:41:41 INFO - PROCESS | 5300 | Values: 72.0 73.0 73.0 81.0 72.0 72.0 74.0 76.0 76.0 72.0 08:41:41 INFO - PROCESS | 5300 | 08:41:41 INFO - PROCESS | 5300 | [#11] stanford-crypto-ccm Cycles:10 Average:126.20 Median:124.50 stddev:14.70 (11.8%) stddev-sans-first:15.21 08:41:41 INFO - PROCESS | 5300 | Values: 117.0 116.0 118.0 135.0 131.0 120.0 116.0 129.0 163.0 117.0 08:41:41 INFO - PROCESS | 5300 | 08:41:41 INFO - PROCESS | 5300 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.90 Median:152.50 stddev:2.33 (1.5%) stddev-sans-first:2.45 08:41:41 INFO - PROCESS | 5300 | Values: 151.0 155.0 152.0 150.0 153.0 148.0 154.0 155.0 150.0 151.0 08:41:41 INFO - PROCESS | 5300 | 08:41:41 INFO - PROCESS | 5300 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.80 Median:61.50 stddev:1.55 (2.5%) stddev-sans-first:1.62 08:41:41 INFO - PROCESS | 5300 | Values: 61.0 65.0 61.0 61.0 62.0 60.0 64.0 62.0 61.0 61.0 08:41:41 INFO - PROCESS | 5300 | -------- Summary: end -------- 08:41:41 INFO - PROCESS | 5300 | 08:41:42 INFO - TEST-INFO | 5300: exit 0 08:41:42 INFO - TEST-OK | kraken | took 60391ms 08:41:42 INFO - SUITE-END | took 1170s 08:41:42 INFO - Completed test suite (00:19:30) 08:41:42 INFO - javascript benchmark 08:41:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7744.576683402936, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3270.149761062124, 3299.6370399256093, 3304.801711897286, 3319.0706602151404, 3319.4356959316915, 5703.515201207897, 5797.739101740422, 5808.2158908547335, 5823.505002074829, 5824.534037277013, 5723.771049158028, 5734.684592347419, 5736.709240420903, 5753.683547404891, 5772.105323674827, 5204.817831375903, 5210.817621383252, 5223.921641175385, 5248.0553500369915, 5250.7637156328055, 5082.745862706868, 5084.949150508503, 5123.1546794778815, 5130.769115389798, 5205.557527610139, 5123.795048198068, 5150.124478838607, 5161.76772045257, 5171.689698618095, 5193.065248255312, 5184.11869982104, 5225.4513276105845, 5226.163813789775, 5228.163493840986, 5251.212318152269, 4919.950800491985, 4994.2508623706735, 5024.874378140539, 5099.15863882459, 5103.591712662978, 5582.609217354787, 5616.9157462638095, 5617.073182924853, 5651.0, 5702.429757024264, 6013.579049466495, 6031.065184896348, 6048.758049678007, 6067.453929146354, 6074.969625151846, 5891.79378721747, 5972.492338151263, 5992.310884248323, 6063.605865618721, 6157.2919114301985, 5614.943850561483, 5689.288838895138, 5693.857653558694, 5710.371859095496, 5725.513331366838, 6224.408681175281, 6237.844053898689, 6239.563230573816, 6247.843803904939, 6269.185005949197, 5827.155062515912, 5846.064629659234, 5957.314908785458, 5982.132590774313, 6004.639721616717, 5937.52499800015, 6046.425589568984, 6087.57386982907, 6095.2685677718955, 6106.053561697944, 6028.5478589106, 6039.758409663565, 6040.577159598874, 6045.063015232646, 6064.999275119556, 5834.474897259267, 5949.9107513387335, 5979.641221526722, 6069.423404776539, 6083.452489275898, 4620.1221767864, 4658.953410465852, 4659.720416774937, 4689.366935463669, 4698.765061746899, 4162.751174647594, 4168.6665066794585, 4171.0615111599645, 4171.416001759756, 4197.76912269822, 5653.689047102449, 5706.457886500859, 5874.295084589877, 5904.261967254093, 5907.497862681635, 6085.056816193497, 6120.479759220427, 6124.816255512342, 6202.596831205957, 6213.03697926822, 5934.43622855828, 5936.37668044849, 5946.554008449383, 5958.255218097738, 5960.433758792908, 5146.485351464824, 5348.625596208228, 5353.785848566014, 5354.464553544614, 5357.571394288448, 6229.127922090911, 6274.215723034621, 6280.466160376419, 6398.872022559616, 6408.807735767934, 6081.331053584191, 6104.511639068953, 6142.3550527194, 6157.938420615916, 6161.815145545641, 6145.924463219008, 6338.619682819046, 6372.044193371032, 6402.871942561216, 6409.0, 5940.673262970406, 5980.790672326448, 5985.581009329305, 6041.6375017499095, 6108.0, 6139.140520327069, 6160.630362178284, 6161.322254552086, 6182.659953702409, 6191.566590338633, 5799.101139323411, 6030.819075427744, 6039.245094363205, 6054.182685337423, 6065.757369705162, 5898.469137777621, 5932.822015339547, 5962.493188079062, 6031.457168854824, 6065.969670151621, 5946.762129514771, 5979.521638269015, 6005.549583781147, 6018.849528761641, 6021.849453763691, 5910.0, 5954.851128721643, 6029.155918171372, 6042.577019608585, 6088.4824789893355, 5794.304683438015, 5837.0368889132815, 5869.970650146722, 5928.940710593011, 5964.493018093337], "value": 5626.038580074169, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [594.1473984831766, 624.9593776404533, 663.7046514301135, 665.5075244319205, 710.12299809735, 42850.0, 46706.53293467064, 47176.29235561469, 47332.29001564975, 47406.52593474068, 45951.0, 46175.30737038947, 46527.30209046867, 46549.069018619695, 46601.0, 9117.316201284897, 9224.907750922506, 9239.02990186031, 9244.399114057565, 9249.075092490764, 9156.633734650639, 9194.58624361902, 9235.584398702074, 9235.630574777, 9263.953680231589, 9235.12266334697, 9280.628774849032, 9292.953535232315, 9296.0, 9300.441973481613, 9137.0, 9157.45055296681, 9157.862632060524, 9199.264058875275, 9224.723258302261, 9136.725898223063, 9195.632174713004, 9196.310276729271, 9225.907740922572, 9255.259579233712, 45053.0, 45453.09093818105, 45690.77154614206, 45701.77149114267, 45721.31418028732, 3567.8929632111076, 3715.3312403767313, 3766.6798322142376, 3790.0903783092135, 3940.389239667856, 35508.822455887814, 35776.28447431037, 35994.8200258997, 36004.63995360039, 37599.24801503982, 4807.807687692523, 4845.355706697143, 4875.609951203895, 4954.975225123887, 5091.338126043591, 419658.0, 419784.0, 422049.0, 423567.8821605903, 425360.0, 69407.65296173588, 69562.3043769566, 69812.0, 69867.3013269871, 69876.0, 63884.0, 69350.0, 71416.28583714097, 71875.2812471879, 73241.6337918307, 18180.818191818176, 18407.447776566725, 18444.170012349477, 18447.446576602724, 18520.351787687367, 13951.511697090553, 13961.79057314141, 14055.22696251716, 14135.363908624136, 14150.150990940576, 20728.689069663968, 20833.89583052075, 21110.0, 21182.78817211839, 21227.15091396327, 7683.807904802313, 7805.37556995439, 7857.882131768028, 7886.763397098096, 7951.960240198878, 1084.9349039057524, 1096.9743290023853, 1145.1525870855507, 1157.3981529604728, 1216.2216181643755, 33554.32891342208, 33941.0, 33968.830155849064, 33980.660193398246, 33983.320333593685, 1137.3744440557825, 1151.9942400287946, 1167.9708007299716, 1189.5241903238773, 1270.2632473165543, 18012.639747204983, 18059.0, 18160.00119993413, 18173.45479635613, 18392.448226553224, 154543.0, 154585.22707386615, 155517.2224138872, 156408.2179589095, 156624.2168789149, 62287.688561556904, 62699.68650156811, 62787.0, 62965.0, 63004.68497657574, 1431.7923901034292, 1464.5459907428944, 1468.6842328899338, 1489.3372449259975, 1500.482333594908, 32697.509537356484, 33525.66474335225, 33529.66470335265, 33627.0, 33669.49495757517, 53771.0, 53973.73013134909, 53977.0, 53977.57100930389, 54008.0, 391340.0, 392387.0, 392829.0, 393242.0, 393250.0, 30270.243243919078, 31130.377392452476, 31338.373232534766, 31361.372772543964, 31385.0, 51525.48474515207, 51549.226761599355, 51636.48363516317, 52129.47870521398, 52219.0, 43360.0, 43729.56270437255, 44498.77750611226, 44633.55366446294, 45567.088658227316, 43912.780436097615, 45045.32432013457, 45903.31145032894, 45985.540144598126, 47065.764671176425, 43414.0, 44838.775806120764, 45119.548804511534, 46529.53470465387, 48476.5152348472, 40705.0, 41280.79359603303, 41504.0, 42081.78959105307, 42400.0, 31141.0, 31297.0, 31382.0, 31525.211869703442, 31848.840755796075], "value": 21015.45858915, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [428.9549597292282, 429.7374373094699, 434.37233198028844, 438.44974556931055, 449.05698034128335, 19050.809491905078, 20036.398908032763, 20619.793802061973, 20847.27034553791, 20932.581348373024, 19385.224591016377, 19943.401697949048, 20187.89906050468, 20188.19247230109, 20216.292429764962, 5958.523318134549, 6171.845703857417, 6205.658688772116, 6216.036514340262, 6219.129321894939, 6110.725017374229, 6119.051547010221, 6153.261608606974, 6169.136320915076, 6189.659568723719, 6089.786857459968, 6152.753889844401, 6163.106349579309, 6163.784267550636, 6164.352742961992, 6077.301110372319, 6097.359777223394, 6117.204763380754, 6122.54080943931, 6140.109684095826, 5311.49540793624, 5508.586855985817, 5523.143912693539, 5524.944750552523, 5531.0873705838485, 22961.196358127552, 23973.76026239733, 24070.51858962811, 24175.153869614656, 24882.253532394057, 2521.0546045233036, 2556.3992461771654, 2866.570014497842, 3154.369126174774, 3161.9525707114412, 11059.944700276528, 11163.441827908571, 11178.32930024193, 11759.882401175964, 14414.42342306317, 1863.3292014874635, 2003.268806885491, 2013.1947221111527, 2037.8675386100003, 2060.9690854637192, 81532.0, 83838.58080709557, 85442.0, 85681.57159214227, 86965.13034869697, 11679.357635329969, 11877.109216808774, 12194.268343899394, 12197.939010304892, 12327.383630818602, 16765.329386824633, 16806.91596542034, 16829.074400907823, 16894.324227031026, 16928.49214523566, 8109.675612975533, 8418.831623367621, 8499.74500764978, 8624.698135565224, 8667.956660216658, 7845.254700803414, 7973.72091976778, 8018.919810801817, 8106.148854370206, 8127.552984585786, 5145.665531740425, 5158.819441319536, 5190.480951904855, 5194.818181363634, 5220.843374698765, 2102.4113248290505, 2182.127149140325, 2196.417949243452, 2205.3163519309064, 2216.667499875032, 955.2644463762864, 986.1272773595276, 987.3335498538457, 994.7712026234007, 1073.863012604926, 21103.366898993056, 21404.143834246766, 21479.892600536896, 21725.67411488829, 21862.672059919114, 1006.5118417567473, 1050.5167622893402, 1085.7122862441458, 1090.0298734126634, 1123.27548731068, 11575.76848463026, 11864.881351186377, 11968.042556595452, 12016.038716902627, 12170.939145304394, 494466.0, 502691.0, 503931.0, 548053.0, 576919.0, 66947.66526167338, 75092.0, 98515.50742246243, 99424.0, 101008.49495752474, 1102.9558817647364, 1111.5998240633367, 1130.2145009218514, 1136.0627482327113, 1140.9315441073395, 18360.0, 18670.906645466686, 18963.810361896205, 19068.523286917938, 19174.233030679174, 37699.43450848185, 39482.2103557933, 41856.79071604623, 42198.0, 43205.56794432015, 54272.0, 61693.691531542056, 62596.374036259054, 62679.686601566704, 63736.0, 8185.754427367188, 8638.395312328077, 8863.645454182019, 9136.862947055932, 9578.13796758295, 13782.65543361424, 14631.0, 14853.851461485247, 14898.851011489747, 15380.846191538389, 12411.317377544321, 12572.736907356764, 12596.370181490705, 13114.344282785632, 13260.801087983495, 12233.531976162918, 12381.00951923862, 12611.36943152857, 12702.67581816388, 12762.48950042025, 12116.21244619097, 12635.0, 12653.240805551697, 12679.049071319872, 13039.348032598142, 8040.758777236459, 8155.266026057683, 8169.591520424074, 8210.0, 8434.746957591282, 11084.61203857861, 12244.0, 12463.18989265731, 12534.498620055096, 12838.03714721381], "value": 9825.403662470013, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1573.9291731872067, 1574.9999999999995, 1765.223301747232, 1890.2439024390242, 1912.6461604603157, 8500.999999999984, 9079.137481939222, 9322.394044387127, 9758.121769040785, 9772.315937884343, 9362.719118426441, 9669.22646188305, 9680.951595242013, 9693.321467497279, 9704.902950970489, 2472.2830379190013, 2523.3060908250195, 2524.5708229601014, 2526.0, 2536.441982763789, 2450.669159663449, 2533.695956485215, 2540.6697129373156, 2544.1985774481072, 2547.0, 2493.1772515070074, 2495.201535508638, 2511.5981442969037, 2527.36815796051, 2528.2415275417393, 2451.9264422067276, 2454.840435371704, 2465.938351541208, 2471.95056098877, 2488.1042824583137, 2437.9756202437925, 2440.2801173653816, 2444.327809852287, 2446.608542633188, 2481.6525686403916, 9934.0, 9942.70171894837, 9985.500724963722, 10017.248706347053, 10024.448655323955, 5576.163575463673, 5693.800716974886, 5719.942800571983, 5720.628159169641, 5726.971365143189, 3578.9284214315567, 3662.6154253803234, 3690.464882592036, 3743.625637436262, 3757.7933213673236, 1132.0999805154922, 1144.914131440137, 1150.413289222494, 1158.1140427572914, 1200.837886885268, 13673.316334183251, 13674.179549227078, 13719.862801371959, 13720.588382348446, 13727.725445491034, 4884.9985752921275, 4963.230699241623, 5017.297578339036, 5074.162763144113, 5133.4096578893905, 11577.552805899262, 11606.187566870407, 11622.535098595961, 11662.591809286634, 11690.240134391237, 5746.454086861741, 5760.913586296209, 5786.450287222707, 5804.6807425592, 5805.390434004453, 4694.765261736899, 5119.155339368963, 5222.608304377187, 5244.711540865213, 5341.599380046512, 4349.652027837766, 4412.713173643703, 4472.731636101845, 4482.5069242383315, 4499.0776890737325, 1341.9731605367838, 1352.3238380809596, 1370.0615078671142, 1370.328539015875, 1401.5585090696397, 938.3244064273712, 1035.7928414317166, 1070.834020726773, 1075.4031512510633, 1088.8747794003632, 6556.606603603704, 6566.770163044271, 6724.831879203059, 6810.523263371517, 6849.931500685029, 471.9098881583553, 480.9158397280462, 1083.967480975572, 1121.7027487715761, 1131.6322195286564, 4393.0994146199955, 4532.229520981441, 4573.885652858638, 4582.083583283356, 4612.446506419251, 11386.94306528462, 11647.941760291314, 12228.449719762632, 12674.619761407173, 12707.174033687781, 11741.119416043832, 11804.70488237801, 11900.940495297642, 11911.761764764657, 11988.580399685969, 8770.0, 9040.773980650536, 9087.000429952699, 9095.727128186165, 9099.954500227457, 6901.896471553031, 7087.893681594884, 7107.857842843217, 7116.25279345682, 7155.8568828624175, 11179.0, 11313.604023859125, 11616.535338586362, 11690.649280521598, 11711.472983715583, 11515.424228788695, 11697.0, 11716.355600442057, 11747.118966077407, 11787.233829801036, 8476.703315383931, 8715.564221788758, 8771.035186129393, 8795.956020219857, 8881.822363552821, 9632.75918102025, 9717.708468745948, 9727.805443891224, 9750.75623109428, 9755.658551950648, 8522.36082293818, 8653.870191947251, 8677.6095075723, 8723.781905452415, 8770.693025744069, 8505.23452889243, 8510.106438823834, 8579.82840343202, 8726.171013753683, 8749.781255468664, 7086.681099350645, 7206.927930720625, 7229.819254518468, 7231.63841807897, 7243.348098671145, 5517.5585953124455, 5539.916901246565, 5614.803481878114, 5746.597738158289, 5863.120531920075, 5679.204911312502, 5742.16738572913, 5807.912881306699, 5849.590528662953, 5873.236479257669], "value": 5082.945424288698, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.123386598041, 347.7461453139208, 348.3781450111551, 355.58574260985955, 355.7563069297533, 5789.639434732834, 5810.680412577307, 5814.127880817874, 5843.532517398608, 5881.206621728982, 5726.770929162839, 5741.540676745861, 5756.683382413966, 5760.193572899798, 5766.961946849566, 4064.0, 4446.933296000562, 4477.888052798674, 4496.875781054737, 4511.458624965009, 4465.397171381855, 4473.66447516436, 4474.843380481684, 4493.662975276868, 4503.57216064475, 4426.867193984185, 4480.6191473724775, 4481.0, 4485.798139083749, 4493.505714371417, 4343.761093139892, 4454.460957254366, 4462.486814016397, 4480.014396832692, 4483.663725220622, 3963.7027222958395, 3967.920641587152, 3973.6821054315587, 3985.8405663773415, 3987.6610488108545, 5508.0, 5523.420040895729, 5547.694876781776, 5566.332040155166, 5599.468050535193, 5000.922955653209, 5116.897662046738, 5156.303898973628, 5163.173892177234, 5167.199084141964, 5963.314218864843, 5964.075568286922, 5966.791162309299, 5980.312264089598, 5986.820395388146, 4296.312589985588, 4369.104333611602, 4380.802863871133, 4388.210122178007, 4399.73601583906, 6189.3907584028475, 6222.906656400158, 6252.81151596942, 6265.7493700251935, 6277.309495955441, 4465.799039043186, 4476.127155204769, 4482.551744825491, 4484.394606728115, 4492.124035812985, 4399.406080179135, 4539.84110556129, 4550.0, 4556.749378784199, 4562.817487300537, 5112.667676601009, 5118.436971933084, 5145.665531740425, 5160.638755287094, 5165.328507294028, 6077.24034495688, 6107.603005804608, 6108.625559249133, 6112.694365281718, 6113.84715382119, 1475.2844870237925, 1538.715337662536, 1563.6481791597027, 1583.5328578069498, 1590.8965917215344, 969.5588507229194, 971.5725080964494, 1012.9088382045651, 1040.458961340099, 1057.2282233969245, 5808.680522571215, 5850.1224816277045, 5855.677937713466, 5859.853503662357, 5904.752386187665, 6102.450779429784, 6166.537509686702, 6180.381961803873, 6203.751849925952, 6218.81343559694, 5771.480566748929, 5779.537636989115, 5816.272965879265, 5832.679202643895, 5889.55705852069, 3247.626522949891, 3277.754168437377, 3288.753343499247, 3290.5393244945726, 3297.3240485700376, 6112.724927378279, 6347.365263473615, 6397.904031439532, 6402.423781859655, 6427.164468619143, 6178.814635560941, 6210.31686514483, 6234.220722409699, 6248.781292654826, 6253.530420351214, 6153.661548614779, 6328.525360597973, 6331.366863313632, 6341.619502829845, 6349.460295874902, 6081.331053584191, 6107.725152368065, 6116.480099191618, 6118.326984031842, 6144.293406258337, 5920.585559010828, 5968.16445697594, 5971.402859713994, 5972.70136493165, 5995.280566332068, 6068.302145253352, 6305.621662700252, 6331.778387756406, 6338.746450142127, 6338.968305158444, 4345.022369966732, 4370.147821174841, 4373.278409062469, 4375.8030888609455, 4387.319965405367, 5992.43071908168, 6122.326544080059, 6132.558848670648, 6132.846678833065, 6154.261488621394, 5954.791582294599, 5963.821085367446, 5967.224260846062, 5972.671503067373, 5991.101334799815, 5947.256592925884, 5980.0, 6001.789937352171, 6003.129546215687, 6006.579539432198, 5791.478766910998, 5846.0, 5930.881382372242, 5948.256467941507, 6108.4807791338235, 6150.138980542638, 6156.692165391623, 6158.846028849135, 6166.876662466815, 6199.814005579839, 5911.822645320647, 6015.248093988252, 6020.518358531394, 6025.6083354581815, 6027.126066720389], "value": 4594.854437160017, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [697.3166297028909, 706.2725392845371, 732.4433430592751, 780.7813812132603, 838.8322335532891, 13517.391717372717, 14429.350679219435, 14487.565373038826, 14536.709265814678, 14558.636034099152, 14339.498117565887, 14505.202213878232, 14558.636034099152, 14603.123812571253, 14948.551543453686, 874.7026011156206, 901.9368644194909, 911.8814554107956, 913.5706218077493, 914.9039350868163, 852.2244757270885, 884.0893879304327, 890.2877697841733, 904.7421484876811, 906.2432868554764, 948.3266880514843, 950.9381890177151, 953.0374321934827, 953.046953046953, 953.6948176583496, 949.093615597103, 949.5394733554186, 949.8052899155656, 950.12588418655, 950.7432993091861, 693.7086423702058, 696.5646470955653, 698.3609996852924, 699.4579201119122, 700.6216643012767, 13995.37020834065, 14028.0, 14111.717765644733, 14235.644108897257, 14288.928555357157, 14701.1914344711, 14794.112353258839, 14998.850011499855, 15010.324535395825, 15121.848781512153, 12707.428165732565, 13082.934585327108, 13183.538576149884, 13350.732985340239, 13486.325683715873, 4019.7588144711412, 4091.1204091120553, 4103.9179216415505, 4126.8761937141935, 4210.831566737357, 70902.0, 81091.59454202751, 81964.0, 84037.15962840416, 84289.0, 11655.76688466226, 12180.695482613006, 12215.816762748565, 12372.62882113538, 12423.565175218824, 21480.785192148192, 21660.891695541737, 21860.234891778713, 22019.779802201774, 22268.331950041524, 8069.6368663410285, 8604.784880377916, 8785.780355491164, 8853.645854165761, 8911.108889111038, 5070.442251352349, 5127.717975511383, 5204.531592156724, 5260.158374660036, 5283.2075188722, 3716.0709822544363, 3839.347310957144, 3839.5968423315708, 3840.1551658635058, 3843.6540711336115, 678.7556479667315, 688.9345512176335, 697.9232284448707, 708.4969671533269, 709.8935159726083, 774.5662429039643, 798.5408390175556, 814.5967745965785, 831.5343407691712, 832.4838600067876, 10646.733831654115, 11021.393823339793, 11069.50187241576, 11173.608923687794, 11601.12991525639, 681.6319187638719, 776.281939206232, 825.4345773145415, 827.0571548434789, 873.4409977614332, 4985.501449854985, 5171.715555644476, 5201.167813149954, 5236.136037553837, 5240.3973543042275, 71222.64388678024, 71252.28747712457, 72765.6361718188, 72766.0, 73544.26455735374, 106942.0, 107188.0, 109121.45439272912, 109528.0, 112331.4383428094, 94671.0, 97426.0, 97845.0, 97854.5107274459, 101100.49449752852, 9887.851682224917, 10539.367637941748, 10633.521491532745, 10663.89336106629, 10682.0, 46408.76795616, 51909.0, 52542.73728631332, 53032.734836327116, 53110.0, 76660.0, 77079.0, 79725.0, 80410.5979470099, 81258.59370703109, 13684.589462316146, 13704.862951370358, 13963.232022238875, 14237.21695306768, 14424.350904209126, 14634.853651463349, 14739.92630036843, 15114.09315441077, 15927.920360398124, 16459.25933332979, 14685.265736712909, 15019.474318398803, 15349.309281082154, 15379.307931142901, 15669.138197399252, 14279.857201428269, 15210.46763363277, 15277.77083343773, 15474.690506190038, 15535.0, 13308.667283317607, 13526.79709804334, 13575.592732218049, 13635.181889086687, 14080.36638351256, 11465.541378345106, 11542.538298467967, 11807.586734464596, 11967.581134660246, 12353.3823308836, 11166.665000050012, 11514.76970460603, 11533.365664888512, 11677.941610291895, 11689.298642081503], "value": 7951.82402874248, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1491.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 112.0, 107.0, 111.0, 114.0, 110.0, 110.0, 112.0, 112.0, 113.0], "value": 110.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 115.0, 146.0, 169.0, 118.0, 147.0, 147.0, 117.0, 170.0, 116.0], "value": 138.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 161.0, 161.0, 163.0, 161.0, 163.0, 160.0, 161.0, 160.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 75.0, 175.0, 75.0, 77.0, 74.0, 74.0, 168.0, 74.0], "value": 94.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 141.0, 84.0, 83.0, 83.0, 149.0, 83.0, 83.0, 142.0], "value": 101.3, "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, 118.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 148.0, 146.0, 148.0, 147.0, 146.0, 148.0, 147.0, 146.0, 146.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 51.0, 55.0, 52.0, 51.0, 55.0, 55.0, 52.0, 53.0, 51.0], "value": 53.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 59.0, 59.0, 59.0, 60.0, 59.0, 59.0, 60.0, 63.0, 59.0], "value": 59.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 73.0, 73.0, 81.0, 72.0, 72.0, 74.0, 76.0, 76.0, 72.0], "value": 74.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 118.0, 135.0, 131.0, 120.0, 116.0, 129.0, 163.0, 117.0], "value": 126.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 155.0, 152.0, 150.0, 153.0, 148.0, 154.0, 155.0, 150.0, 151.0], "value": 151.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 65.0, 61.0, 61.0, 62.0, 60.0, 64.0, 62.0, 61.0, 61.0], "value": 61.8, "unit": "score"}]}]} 08:41:42 INFO - Return code: 0 08:41:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:41:42 ERROR - # TBPL SUCCESS # 08:41:42 INFO - Running post-action listener: _resource_record_post_action 08:41:42 INFO - [mozharness: 2016-09-26 15:41:42.892985Z] Finished run-tests step (success) 08:41:42 INFO - Running post-run listener: _resource_record_post_run 08:41:42 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 2064384; Write bytes: 290942976; Read time: 344; Write time: 248220 08:41:42 INFO - TinderboxPrint: CPU usage
13.2% 08:41:42 INFO - TinderboxPrint: I/O read bytes / time
2,064,384 / 344 08:41:42 INFO - TinderboxPrint: I/O write bytes / time
290,942,976 / 248,220 08:41:42 INFO - TinderboxPrint: CPU idle
8,211.4 (86.8%) 08:41:42 INFO - TinderboxPrint: CPU user
1,191.8 (12.6%) 08:41:42 INFO - TinderboxPrint: Swap in / out
0 / 0 08:41:42 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 71393280; Read time: 0; Write time: 128748 08:41:42 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 192512; Write bytes: 219549696; Read time: 44; Write time: 119472 08:41:43 INFO - Running post-run listener: _upload_blobber_files 08:41:43 INFO - Blob upload gear active. 08:41:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:41:43 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 08:41:43 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'] 08:41:43 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 08:41:43 INFO - (blobuploader) - INFO - Open directory for files ... 08:41:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:41:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:41:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:41:47 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:41:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:41:47 INFO - (blobuploader) - INFO - Done attempting. 08:41:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:41:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:41:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:41:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:41:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:41:48 INFO - (blobuploader) - INFO - Done attempting. 08:41:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:41:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:41:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:41:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:41:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:41:49 INFO - (blobuploader) - INFO - Done attempting. 08:41:49 INFO - (blobuploader) - INFO - Iteration through files over. 08:41:49 INFO - Return code: 0 08:41:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:41:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:41:49 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6340726e2c7ba4c03a12744bc9f73d339341212fa95171224d17569a4a02f6caf2dcaa8371b7cba997507ac2e6f4a554c43b303d02995c2a4e0b389574439db3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/eef87a5edac85147646f71952dc38400f86cfe408d29a557a72c4a38a8aa42947f7cf536eafad79f54c601f691bf9f2865f74f1386ad83c31eb628c4abb7477b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c1be858d0116a10663afa396f74c396842b9d20fe7a2c8dae57f554817eeb67d29422bd6b45988bd73bc04c7104f0d85feef982343861392c21ead8f3650b5c1"} 08:41:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:41:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:41:49 INFO - Contents: 08:41:49 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6340726e2c7ba4c03a12744bc9f73d339341212fa95171224d17569a4a02f6caf2dcaa8371b7cba997507ac2e6f4a554c43b303d02995c2a4e0b389574439db3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/eef87a5edac85147646f71952dc38400f86cfe408d29a557a72c4a38a8aa42947f7cf536eafad79f54c601f691bf9f2865f74f1386ad83c31eb628c4abb7477b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c1be858d0116a10663afa396f74c396842b9d20fe7a2c8dae57f554817eeb67d29422bd6b45988bd73bc04c7104f0d85feef982343861392c21ead8f3650b5c1"} 08:41:49 INFO - Running post-run listener: copy_logs_to_upload_dir 08:41:49 INFO - Copying logs to upload dir... 08:41:49 INFO - mkdir: /builds/slave/test/build/upload/logs 08:41:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1674.386247 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 54 secs) (at 2016-09-26 08:41:49.256162) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-26 08:41:49.259553) ========= 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=32c5991c409366f7fec8a718000001d2-1474901408.416707-68565470 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/6340726e2c7ba4c03a12744bc9f73d339341212fa95171224d17569a4a02f6caf2dcaa8371b7cba997507ac2e6f4a554c43b303d02995c2a4e0b389574439db3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/eef87a5edac85147646f71952dc38400f86cfe408d29a557a72c4a38a8aa42947f7cf536eafad79f54c601f691bf9f2865f74f1386ad83c31eb628c4abb7477b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c1be858d0116a10663afa396f74c396842b9d20fe7a2c8dae57f554817eeb67d29422bd6b45988bd73bc04c7104f0d85feef982343861392c21ead8f3650b5c1"} build_url:https://queue.taskcluster.net/v1/task/Pl5oGT5vQI2YLZqH_E7j4Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011339 build_url: 'https://queue.taskcluster.net/v1/task/Pl5oGT5vQI2YLZqH_E7j4Q/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/6340726e2c7ba4c03a12744bc9f73d339341212fa95171224d17569a4a02f6caf2dcaa8371b7cba997507ac2e6f4a554c43b303d02995c2a4e0b389574439db3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/eef87a5edac85147646f71952dc38400f86cfe408d29a557a72c4a38a8aa42947f7cf536eafad79f54c601f691bf9f2865f74f1386ad83c31eb628c4abb7477b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c1be858d0116a10663afa396f74c396842b9d20fe7a2c8dae57f554817eeb67d29422bd6b45988bd73bc04c7104f0d85feef982343861392c21ead8f3650b5c1"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-26 08:41:49.286697) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 08:41:49.287410) ========= 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=32c5991c409366f7fec8a718000001d2-1474901408.416707-68565470 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004454 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 08:41:49.366626) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-26 08:41:49.366892) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-26 08:41:49.367156) ========= ========= Total master_lag: 0.22 =========