builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-050 starttime: 1474302701.24 results: success (0) buildid: 20160919064031 builduid: ae1839bfaf4840dab36e395afce28275 revision: 01d67bfe6c8198416ec190cbc216d953c1625b94 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-19 09:31:41.244729) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-19 09:31:41.245335) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-19 09:31:41.245761) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-19 09:31:41.261388) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-19 09:31:41.261812) ========= 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=6dbc10da6d83fee962c624be000001a8-1474302692.58684-1942397390 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-19 09:31:41-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.7M=0s 2016-09-19 09:31:41 (42.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.127064 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-19 09:31:41.402922) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-19 09:31:41.403251) ========= 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=6dbc10da6d83fee962c624be000001a8-1474302692.58684-1942397390 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017296 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-19 09:31:41.452338) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-19 09:31:41.452717) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 01d67bfe6c8198416ec190cbc216d953c1625b94 --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 01d67bfe6c8198416ec190cbc216d953c1625b94 --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=6dbc10da6d83fee962c624be000001a8-1474302692.58684-1942397390 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-19 09:31:41,651 truncating revision to first 12 chars 2016-09-19 09:31:41,651 Setting DEBUG logging. 2016-09-19 09:31:41,651 attempt 1/10 2016-09-19 09:31:41,651 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/01d67bfe6c81?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-19 09:31:42,958 unpacking tar archive at: mozilla-beta-01d67bfe6c81/testing/mozharness/ program finished with exit code 0 elapsedTime=1.644479 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-19 09:31:43.111993) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-19 09:31:43.112322) ========= script_repo_revision: 01d67bfe6c8198416ec190cbc216d953c1625b94 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-19 09:31:43.112757) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-19 09:31:43.113042) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-19 09:31:43.122128) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 54 secs) (at 2016-09-19 09:31:43.122569) ========= /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=6dbc10da6d83fee962c624be000001a8-1474302692.58684-1942397390 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:31:43 INFO - MultiFileLogger online at 20160919 09:31:43 in /builds/slave/test 09:31:43 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 09:31:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:31:43 INFO - {'append_to_log': False, 09:31:43 INFO - 'base_work_dir': '/builds/slave/test', 09:31:43 INFO - 'blob_upload_branch': 'Mozilla-Beta', 09:31:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:31:43 INFO - 'branch': 'Mozilla-Beta', 09:31:43 INFO - 'buildbot_json_path': 'buildprops.json', 09:31:43 INFO - 'config_files': ('talos/linux_config.py',), 09:31:43 INFO - 'default_actions': ('clobber', 09:31:43 INFO - 'read-buildbot-config', 09:31:43 INFO - 'download-and-extract', 09:31:43 INFO - 'populate-webroot', 09:31:43 INFO - 'create-virtualenv', 09:31:43 INFO - 'install', 09:31:43 INFO - 'run-tests'), 09:31:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:31:43 INFO - 'download_minidump_stackwalk': True, 09:31:43 INFO - 'download_symbols': 'ondemand', 09:31:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:31:43 INFO - 'tooltool.py': '/tools/tooltool.py', 09:31:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:31:43 INFO - '/tools/misc-python/virtualenv.py')}, 09:31:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:31:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:31:43 INFO - 'installer_path': 'installer.exe', 09:31:43 INFO - 'log_level': 'info', 09:31:43 INFO - 'log_name': 'talos', 09:31:43 INFO - 'log_to_console': True, 09:31:43 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:31:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:31:43 INFO - 'opt_config_files': (), 09:31:43 INFO - 'pip_index': False, 09:31:43 INFO - 'sps_profile': False, 09:31:43 INFO - 'sps_profile_interval': 0, 09:31:43 INFO - 'suite': 'dromaeojs-e10s', 09:31:43 INFO - 'system_bits': '32', 09:31:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:31:43 INFO - 'title': 'talos-linux64-ix-050', 09:31:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:31:43 INFO - 'use_talos_json': True, 09:31:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:31:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:31:43 INFO - 'work_dir': 'build'} 09:31:43 INFO - [mozharness: 2016-09-19 16:31:43.417762Z] Running clobber step. 09:31:43 INFO - Running pre-action listener: _resource_record_pre_action 09:31:43 INFO - Running main action method: clobber 09:31:43 INFO - rmtree: /builds/slave/test/build 09:31:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:31:44 INFO - Running post-action listener: _resource_record_post_action 09:31:44 INFO - [mozharness: 2016-09-19 16:31:44.391908Z] Finished clobber step (success) 09:31:44 INFO - [mozharness: 2016-09-19 16:31:44.392010Z] Running read-buildbot-config step. 09:31:44 INFO - Running pre-action listener: _resource_record_pre_action 09:31:44 INFO - Running main action method: read_buildbot_config 09:31:44 INFO - Using buildbot properties: 09:31:44 INFO - { 09:31:44 INFO - "project": "", 09:31:44 INFO - "product": "firefox", 09:31:44 INFO - "script_repo_revision": "production", 09:31:44 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 09:31:44 INFO - "repository": "", 09:31:44 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 09:31:44 INFO - "buildid": "20160919064031", 09:31:44 INFO - "pgo_build": "True", 09:31:44 INFO - "basedir": "/builds/slave/test", 09:31:44 INFO - "buildnumber": 234, 09:31:44 INFO - "slavename": "talos-linux64-ix-050", 09:31:44 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:31:44 INFO - "platform": "ubuntu64_hw", 09:31:44 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 09:31:44 INFO - "branch": "mozilla-beta", 09:31:44 INFO - "repo_path": "releases/mozilla-beta", 09:31:44 INFO - "revision": "01d67bfe6c8198416ec190cbc216d953c1625b94", 09:31:44 INFO - "stage_platform": "linux64-pgo", 09:31:44 INFO - "builduid": "ae1839bfaf4840dab36e395afce28275", 09:31:44 INFO - "slavebuilddir": "test" 09:31:44 INFO - } 09:31:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/NP4rm_HuS0OWUwXOhIFq3A/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2. 09:31:44 INFO - Running post-action listener: _resource_record_post_action 09:31:44 INFO - [mozharness: 2016-09-19 16:31:44.394438Z] Finished read-buildbot-config step (success) 09:31:44 INFO - [mozharness: 2016-09-19 16:31:44.394527Z] Running download-and-extract step. 09:31:44 INFO - Running pre-action listener: _resource_record_pre_action 09:31:44 INFO - Running main action method: download_and_extract 09:31:44 INFO - mkdir: /builds/slave/test/build/tests 09:31:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:31:44 INFO - https://queue.taskcluster.net/v1/task/NP4rm_HuS0OWUwXOhIFq3A/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:31:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NP4rm_HuS0OWUwXOhIFq3A/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 09:31:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NP4rm_HuS0OWUwXOhIFq3A/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 09:31:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NP4rm_HuS0OWUwXOhIFq3A/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 09:31:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NP4rm_HuS0OWUwXOhIFq3A/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 09:31:44 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NP4rm_HuS0OWUwXOhIFq3A/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 09:31:44 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 09:31:44 INFO - retry: Failed, sleeping 30 seconds before retrying 09:32:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NP4rm_HuS0OWUwXOhIFq3A/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 09:32:14 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NP4rm_HuS0OWUwXOhIFq3A/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 09:32:14 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 09:32:14 INFO - retry: Failed, sleeping 60 seconds before retrying 09:33:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NP4rm_HuS0OWUwXOhIFq3A/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 09:33:14 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NP4rm_HuS0OWUwXOhIFq3A/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 09:33:14 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 09:33:14 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NP4rm_HuS0OWUwXOhIFq3A/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! 09:33:14 INFO - Caught exception: HTTP Error 404: Not Found 09:33:14 INFO - Caught exception: HTTP Error 404: Not Found 09:33:14 INFO - Caught exception: HTTP Error 404: Not Found 09:33:14 INFO - trying https://queue.taskcluster.net/v1/task/NP4rm_HuS0OWUwXOhIFq3A/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 09:33:14 INFO - Downloading https://queue.taskcluster.net/v1/task/NP4rm_HuS0OWUwXOhIFq3A/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 09:33:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NP4rm_HuS0OWUwXOhIFq3A/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 09:33:15 INFO - Downloaded 1327 bytes. 09:33:15 INFO - Reading from file /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 09:33:15 INFO - Using the following test package requirements: 09:33:15 INFO - {u'common': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'], 09:33:15 INFO - u'cppunittest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 09:33:15 INFO - u'firefox-50.0.en-US.linux-x86_64.cppunittest.tests.zip'], 09:33:15 INFO - u'gtest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 09:33:15 INFO - u'firefox-50.0.en-US.linux-x86_64.gtest.tests.zip'], 09:33:15 INFO - u'jittest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 09:33:15 INFO - u'jsshell-linux-x86_64.zip'], 09:33:15 INFO - u'mochitest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 09:33:15 INFO - u'firefox-50.0.en-US.linux-x86_64.mochitest.tests.zip'], 09:33:15 INFO - u'mozbase': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'], 09:33:15 INFO - u'reftest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 09:33:15 INFO - u'firefox-50.0.en-US.linux-x86_64.reftest.tests.zip'], 09:33:15 INFO - u'talos': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 09:33:15 INFO - u'firefox-50.0.en-US.linux-x86_64.talos.tests.zip'], 09:33:15 INFO - u'web-platform': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 09:33:15 INFO - u'firefox-50.0.en-US.linux-x86_64.web-platform.tests.zip'], 09:33:15 INFO - u'xpcshell': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 09:33:15 INFO - u'firefox-50.0.en-US.linux-x86_64.xpcshell.tests.zip']} 09:33:15 INFO - Downloading packages: [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:33:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:33:15 INFO - https://queue.taskcluster.net/v1/task/NP4rm_HuS0OWUwXOhIFq3A/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:33:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NP4rm_HuS0OWUwXOhIFq3A/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 09:33:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NP4rm_HuS0OWUwXOhIFq3A/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 09:33:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NP4rm_HuS0OWUwXOhIFq3A/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 09:33:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NP4rm_HuS0OWUwXOhIFq3A/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 09:33:15 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NP4rm_HuS0OWUwXOhIFq3A/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 09:33:15 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 09:33:15 INFO - retry: Failed, sleeping 30 seconds before retrying 09:33:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NP4rm_HuS0OWUwXOhIFq3A/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 09:33:45 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NP4rm_HuS0OWUwXOhIFq3A/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 09:33:45 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 09:33:45 INFO - retry: Failed, sleeping 60 seconds before retrying 09:34:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NP4rm_HuS0OWUwXOhIFq3A/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 09:34:45 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NP4rm_HuS0OWUwXOhIFq3A/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 09:34:45 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 09:34:45 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NP4rm_HuS0OWUwXOhIFq3A/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! 09:34:45 INFO - Caught exception: HTTP Error 404: Not Found 09:34:45 INFO - Caught exception: HTTP Error 404: Not Found 09:34:45 INFO - Caught exception: HTTP Error 404: Not Found 09:34:45 INFO - trying https://queue.taskcluster.net/v1/task/NP4rm_HuS0OWUwXOhIFq3A/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 09:34:45 INFO - Downloading https://queue.taskcluster.net/v1/task/NP4rm_HuS0OWUwXOhIFq3A/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 09:34:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NP4rm_HuS0OWUwXOhIFq3A/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 09:34:46 INFO - Downloaded 21772072 bytes. 09:34:46 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'] 09:34:46 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 09:34:47 INFO - Return code: 0 09:34:47 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 09:34:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:34:47 INFO - https://queue.taskcluster.net/v1/task/NP4rm_HuS0OWUwXOhIFq3A/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:34:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NP4rm_HuS0OWUwXOhIFq3A/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 09:34:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NP4rm_HuS0OWUwXOhIFq3A/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 09:34:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NP4rm_HuS0OWUwXOhIFq3A/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 09:34:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NP4rm_HuS0OWUwXOhIFq3A/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 09:34:47 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NP4rm_HuS0OWUwXOhIFq3A/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 09:34:47 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 09:34:47 INFO - retry: Failed, sleeping 30 seconds before retrying 09:35:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NP4rm_HuS0OWUwXOhIFq3A/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 09:35:17 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NP4rm_HuS0OWUwXOhIFq3A/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 09:35:17 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 09:35:17 INFO - retry: Failed, sleeping 60 seconds before retrying 09:36:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NP4rm_HuS0OWUwXOhIFq3A/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 09:36:17 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NP4rm_HuS0OWUwXOhIFq3A/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 09:36:17 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 09:36:17 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NP4rm_HuS0OWUwXOhIFq3A/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! 09:36:17 INFO - Caught exception: HTTP Error 404: Not Found 09:36:17 INFO - Caught exception: HTTP Error 404: Not Found 09:36:17 INFO - Caught exception: HTTP Error 404: Not Found 09:36:17 INFO - trying https://queue.taskcluster.net/v1/task/NP4rm_HuS0OWUwXOhIFq3A/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 09:36:17 INFO - Downloading https://queue.taskcluster.net/v1/task/NP4rm_HuS0OWUwXOhIFq3A/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 09:36:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NP4rm_HuS0OWUwXOhIFq3A/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 09:36:18 INFO - Downloaded 21772072 bytes. 09:36:18 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'] 09:36:18 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 09:36:19 INFO - Return code: 0 09:36:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:36:19 INFO - https://queue.taskcluster.net/v1/task/NP4rm_HuS0OWUwXOhIFq3A/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:36:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NP4rm_HuS0OWUwXOhIFq3A/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 09:36:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NP4rm_HuS0OWUwXOhIFq3A/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 09:36:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NP4rm_HuS0OWUwXOhIFq3A/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 09:36:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NP4rm_HuS0OWUwXOhIFq3A/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 09:36:19 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NP4rm_HuS0OWUwXOhIFq3A/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 09:36:19 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 09:36:19 INFO - retry: Failed, sleeping 30 seconds before retrying 09:36:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NP4rm_HuS0OWUwXOhIFq3A/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 09:36:49 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NP4rm_HuS0OWUwXOhIFq3A/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 09:36:49 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 09:36:49 INFO - retry: Failed, sleeping 60 seconds before retrying 09:37:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NP4rm_HuS0OWUwXOhIFq3A/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 09:37:49 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NP4rm_HuS0OWUwXOhIFq3A/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 09:37:49 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 09:37:49 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NP4rm_HuS0OWUwXOhIFq3A/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! 09:37:49 INFO - Caught exception: HTTP Error 404: Not Found 09:37:49 INFO - Caught exception: HTTP Error 404: Not Found 09:37:49 INFO - Caught exception: HTTP Error 404: Not Found 09:37:49 INFO - trying https://queue.taskcluster.net/v1/task/NP4rm_HuS0OWUwXOhIFq3A/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 09:37:49 INFO - Downloading https://queue.taskcluster.net/v1/task/NP4rm_HuS0OWUwXOhIFq3A/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 09:37:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NP4rm_HuS0OWUwXOhIFq3A/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 09:37:50 INFO - Downloaded 14413740 bytes. 09:37:50 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'] 09:37:50 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 09:37:50 INFO - Return code: 0 09:37:50 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')]} 09:37:50 INFO - https://queue.taskcluster.net/v1/task/NP4rm_HuS0OWUwXOhIFq3A/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:37:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NP4rm_HuS0OWUwXOhIFq3A/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 09:37:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NP4rm_HuS0OWUwXOhIFq3A/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 09:37:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NP4rm_HuS0OWUwXOhIFq3A/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 09:37:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NP4rm_HuS0OWUwXOhIFq3A/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 09:37:50 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NP4rm_HuS0OWUwXOhIFq3A/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 09:37:50 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 09:37:50 INFO - retry: Failed, sleeping 30 seconds before retrying 09:38:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NP4rm_HuS0OWUwXOhIFq3A/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 09:38:20 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NP4rm_HuS0OWUwXOhIFq3A/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 09:38:20 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 09:38:20 INFO - retry: Failed, sleeping 60 seconds before retrying 09:39:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NP4rm_HuS0OWUwXOhIFq3A/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 09:39:20 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NP4rm_HuS0OWUwXOhIFq3A/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 09:39:20 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 09:39:20 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NP4rm_HuS0OWUwXOhIFq3A/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! 09:39:20 INFO - Caught exception: HTTP Error 404: Not Found 09:39:20 INFO - Caught exception: HTTP Error 404: Not Found 09:39:20 INFO - Caught exception: HTTP Error 404: Not Found 09:39:20 INFO - trying https://queue.taskcluster.net/v1/task/NP4rm_HuS0OWUwXOhIFq3A/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 09:39:20 INFO - Downloading https://queue.taskcluster.net/v1/task/NP4rm_HuS0OWUwXOhIFq3A/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 09:39:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NP4rm_HuS0OWUwXOhIFq3A/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 09:39:21 INFO - Downloaded 56767399 bytes. 09:39:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NP4rm_HuS0OWUwXOhIFq3A/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 09:39:21 INFO - mkdir: /builds/slave/test/properties 09:39:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:39:21 INFO - Writing to file /builds/slave/test/properties/build_url 09:39:21 INFO - Contents: 09:39:21 INFO - build_url:https://queue.taskcluster.net/v1/task/NP4rm_HuS0OWUwXOhIFq3A/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 09:39:22 INFO - Running post-action listener: _resource_record_post_action 09:39:22 INFO - Running post-action listener: set_extra_try_arguments 09:39:22 INFO - [mozharness: 2016-09-19 16:39:22.517305Z] Finished download-and-extract step (success) 09:39:22 INFO - [mozharness: 2016-09-19 16:39:22.517537Z] Running populate-webroot step. 09:39:22 INFO - Running pre-action listener: _resource_record_pre_action 09:39:22 INFO - Running main action method: populate_webroot 09:39:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:39:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:39:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:39:22 INFO - '--tppagecycles', 09:39:22 INFO - '7'], 09:39:22 INFO - 'tests': ['tsvgm']}}, 09:39:22 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:39:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:39:22 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:39:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:39:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:39:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:39:22 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:39:22 INFO - 'talos_options': ['--disable-e10s'], 09:39:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:39:22 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:39:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:39:22 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:39:22 INFO - 'talos_options': ['--disable-e10s'], 09:39:22 INFO - 'tests': ['damp', 'tps']}, 09:39:22 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:39:22 INFO - 'tests': ['damp', 'tps']}, 09:39:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:39:22 INFO - 'tests': ['dromaeo_dom']}, 09:39:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:39:22 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:39:22 INFO - 'tests': ['basic_compositor_video']}, 09:39:22 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:39:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:39:22 INFO - 'tests': ['a11yr', 09:39:22 INFO - 'ts_paint', 09:39:22 INFO - 'tpaint', 09:39:22 INFO - 'sessionrestore', 09:39:22 INFO - 'sessionrestore_no_auto_restore', 09:39:22 INFO - 'tabpaint']}, 09:39:22 INFO - 'other-e10s': {'tests': ['a11yr', 09:39:22 INFO - 'ts_paint', 09:39:22 INFO - 'tpaint', 09:39:22 INFO - 'sessionrestore', 09:39:22 INFO - 'sessionrestore_no_auto_restore', 09:39:22 INFO - 'tabpaint']}, 09:39:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:39:22 INFO - 'ts_paint', 09:39:22 INFO - 'tpaint', 09:39:22 INFO - 'sessionrestore', 09:39:22 INFO - 'sessionrestore_no_auto_restore', 09:39:22 INFO - 'tabpaint']}, 09:39:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:39:22 INFO - 'ts_paint', 09:39:22 INFO - 'tpaint', 09:39:22 INFO - 'sessionrestore', 09:39:22 INFO - 'sessionrestore_no_auto_restore', 09:39:22 INFO - 'tabpaint']}, 09:39:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:39:22 INFO - 'tests': ['a11yr', 09:39:22 INFO - 'ts_paint', 09:39:22 INFO - 'tpaint', 09:39:22 INFO - 'sessionrestore', 09:39:22 INFO - 'sessionrestore_no_auto_restore', 09:39:22 INFO - 'tabpaint']}, 09:39:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:39:22 INFO - 'tests': ['a11yr', 09:39:22 INFO - 'ts_paint', 09:39:22 INFO - 'tpaint', 09:39:22 INFO - 'sessionrestore', 09:39:22 INFO - 'sessionrestore_no_auto_restore', 09:39:22 INFO - 'tabpaint']}, 09:39:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:39:22 INFO - 'tests': ['tsvgx', 09:39:22 INFO - 'tsvgr_opacity', 09:39:22 INFO - 'tart', 09:39:22 INFO - 'tscrollx', 09:39:22 INFO - 'cart']}, 09:39:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:39:22 INFO - 'tsvgr_opacity', 09:39:22 INFO - 'tart', 09:39:22 INFO - 'tscrollx', 09:39:22 INFO - 'cart']}, 09:39:22 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:39:22 INFO - 'talos_options': ['--disable-e10s'], 09:39:22 INFO - 'tests': ['tp5o']}, 09:39:22 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:39:22 INFO - 'tests': ['tp5o']}, 09:39:22 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:39:22 INFO - 'talos_options': ['--disable-e10s', 09:39:22 INFO - '--xperf_path', 09:39:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:39:22 INFO - 'tests': ['tp5n']}, 09:39:22 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:39:22 INFO - 'talos_options': ['--xperf_path', 09:39:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:39:22 INFO - 'tests': ['tp5n']}}, 09:39:22 INFO - 'talos.zip': {'path': '', 09:39:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:39:22 INFO - Running post-action listener: _resource_record_post_action 09:39:22 INFO - [mozharness: 2016-09-19 16:39:22.533747Z] Finished populate-webroot step (success) 09:39:22 INFO - [mozharness: 2016-09-19 16:39:22.533836Z] Running create-virtualenv step. 09:39:22 INFO - Running pre-action listener: _resource_record_pre_action 09:39:22 INFO - Running main action method: create_virtualenv 09:39:22 INFO - Creating virtualenv /builds/slave/test/build/venv 09:39:22 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 09:39:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:39:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:39:22 INFO - Using real prefix '/usr' 09:39:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:39:23 INFO - Installing distribute.............................................................................................................................................................................................done. 09:39:25 INFO - Installing pip.................done. 09:39:25 INFO - Return code: 0 09:39:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:39:25 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')]} 09:39:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:39:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:25 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')]} 09:39:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:39:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:25 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 0x1dd3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2002400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2091570>, '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 0x2092470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2092900>, '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': '6dbc10da6d83fee962c624be000001a8-1474302692.58684-1942397390', '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 09:39:25 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 09:39:25 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 09:39:25 INFO - Using env: {'DISPLAY': ':0', 09:39:25 INFO - 'HOME': '/home/cltbld', 09:39:25 INFO - 'LANG': 'en_US.UTF-8', 09:39:25 INFO - 'LANGUAGE': 'en_US:en', 09:39:25 INFO - 'LOGNAME': 'cltbld', 09:39:25 INFO - 'MAIL': '/var/mail/cltbld', 09:39:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:39:25 INFO - 'MOZ_NO_REMOTE': '1', 09:39:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:39:25 INFO - 'NO_EM_RESTART': '1', 09:39:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:39:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:39:25 INFO - 'PWD': '/builds/slave/test', 09:39:25 INFO - 'SHELL': '/bin/bash', 09:39:25 INFO - 'SHLVL': '1', 09:39:25 INFO - 'TERM': 'linux', 09:39:25 INFO - 'TMOUT': '86400', 09:39:25 INFO - 'USER': 'cltbld', 09:39:25 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1474302692.58684-1942397390', 09:39:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:39:25 INFO - '_': '/tools/buildbot/bin/python'} 09:39:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:39:25 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 09:39:25 INFO - Cleaning up... 09:39:25 INFO - Return code: 0 09:39:25 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:39:25 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')]} 09:39:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:39:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:25 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')]} 09:39:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:39:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:25 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 0x1dd3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2002400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2091570>, '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 0x2092470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2092900>, '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': '6dbc10da6d83fee962c624be000001a8-1474302692.58684-1942397390', '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 09:39:25 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 09:39:25 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 09:39:25 INFO - Using env: {'DISPLAY': ':0', 09:39:25 INFO - 'HOME': '/home/cltbld', 09:39:25 INFO - 'LANG': 'en_US.UTF-8', 09:39:25 INFO - 'LANGUAGE': 'en_US:en', 09:39:25 INFO - 'LOGNAME': 'cltbld', 09:39:25 INFO - 'MAIL': '/var/mail/cltbld', 09:39:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:39:25 INFO - 'MOZ_NO_REMOTE': '1', 09:39:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:39:25 INFO - 'NO_EM_RESTART': '1', 09:39:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:39:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:39:25 INFO - 'PWD': '/builds/slave/test', 09:39:25 INFO - 'SHELL': '/bin/bash', 09:39:25 INFO - 'SHLVL': '1', 09:39:25 INFO - 'TERM': 'linux', 09:39:25 INFO - 'TMOUT': '86400', 09:39:25 INFO - 'USER': 'cltbld', 09:39:25 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1474302692.58684-1942397390', 09:39:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:39:25 INFO - '_': '/tools/buildbot/bin/python'} 09:39:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:39:25 INFO - Downloading/unpacking psutil>=3.1.1 09:39:25 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 09:39:25 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 09:39:25 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 09:39:25 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 09:39:25 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 09:39:25 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 09:39:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:39:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:39:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:39:27 INFO - Installing collected packages: psutil 09:39:27 INFO - Running setup.py install for psutil 09:39:27 INFO - building 'psutil._psutil_linux' extension 09:39:27 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 09:39:27 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 09:39:27 INFO - building 'psutil._psutil_posix' extension 09:39:27 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 09:39:27 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 09:39:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:39:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:39:28 INFO - Successfully installed psutil 09:39:28 INFO - Cleaning up... 09:39:28 INFO - Return code: 0 09:39:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:39:28 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')]} 09:39:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:39:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:28 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')]} 09:39:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:39:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:28 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 0x1dd3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2002400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2091570>, '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 0x2092470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2092900>, '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': '6dbc10da6d83fee962c624be000001a8-1474302692.58684-1942397390', '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 09:39:28 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 09:39:28 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 09:39:28 INFO - Using env: {'DISPLAY': ':0', 09:39:28 INFO - 'HOME': '/home/cltbld', 09:39:28 INFO - 'LANG': 'en_US.UTF-8', 09:39:28 INFO - 'LANGUAGE': 'en_US:en', 09:39:28 INFO - 'LOGNAME': 'cltbld', 09:39:28 INFO - 'MAIL': '/var/mail/cltbld', 09:39:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:39:28 INFO - 'MOZ_NO_REMOTE': '1', 09:39:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:39:28 INFO - 'NO_EM_RESTART': '1', 09:39:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:39:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:39:28 INFO - 'PWD': '/builds/slave/test', 09:39:28 INFO - 'SHELL': '/bin/bash', 09:39:28 INFO - 'SHLVL': '1', 09:39:28 INFO - 'TERM': 'linux', 09:39:28 INFO - 'TMOUT': '86400', 09:39:28 INFO - 'USER': 'cltbld', 09:39:28 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1474302692.58684-1942397390', 09:39:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:39:28 INFO - '_': '/tools/buildbot/bin/python'} 09:39:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:39:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:39:28 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 09:39:28 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 09:39:28 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 09:39:28 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 09:39:28 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 09:39:28 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 09:39:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:39:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:39:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:39:30 INFO - Installing collected packages: mozsystemmonitor 09:39:30 INFO - Running setup.py install for mozsystemmonitor 09:39:30 INFO - Successfully installed mozsystemmonitor 09:39:30 INFO - Cleaning up... 09:39:30 INFO - Return code: 0 09:39:30 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:39: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')]} 09:39:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:39:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39: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')]} 09:39:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:39:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:30 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 0x1dd3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2002400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2091570>, '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 0x2092470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2092900>, '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': '6dbc10da6d83fee962c624be000001a8-1474302692.58684-1942397390', '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 09:39:30 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 09:39:30 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 09:39:30 INFO - Using env: {'DISPLAY': ':0', 09:39:30 INFO - 'HOME': '/home/cltbld', 09:39:30 INFO - 'LANG': 'en_US.UTF-8', 09:39:30 INFO - 'LANGUAGE': 'en_US:en', 09:39:30 INFO - 'LOGNAME': 'cltbld', 09:39:30 INFO - 'MAIL': '/var/mail/cltbld', 09:39:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:39:30 INFO - 'MOZ_NO_REMOTE': '1', 09:39:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:39:30 INFO - 'NO_EM_RESTART': '1', 09:39:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:39:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:39:30 INFO - 'PWD': '/builds/slave/test', 09:39:30 INFO - 'SHELL': '/bin/bash', 09:39:30 INFO - 'SHLVL': '1', 09:39:30 INFO - 'TERM': 'linux', 09:39:30 INFO - 'TMOUT': '86400', 09:39:30 INFO - 'USER': 'cltbld', 09:39:30 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1474302692.58684-1942397390', 09:39:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:39:30 INFO - '_': '/tools/buildbot/bin/python'} 09:39:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:39:30 INFO - Downloading/unpacking jsonschema==2.5.1 09:39:30 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 09:39:30 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 09:39:30 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 09:39:30 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 09:39:30 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 09:39:30 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 09:39:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:39:32 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:39:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:39:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:39:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:39:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:39:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:39:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:39:32 INFO - Downloading functools32-3.2.3-2.tar.gz 09:39:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:39:32 INFO - warning: no files found matching '*.txt' 09:39:32 INFO - no previously-included directories found matching 'build' 09:39:32 INFO - no previously-included directories found matching 'dist' 09:39:32 INFO - no previously-included directories found matching '.git*' 09:39:32 INFO - Installing collected packages: jsonschema, functools32 09:39:32 INFO - Running setup.py install for functools32 09:39:32 INFO - warning: no files found matching '*.txt' 09:39:32 INFO - no previously-included directories found matching 'build' 09:39:32 INFO - no previously-included directories found matching 'dist' 09:39:32 INFO - no previously-included directories found matching '.git*' 09:39:32 INFO - Successfully installed jsonschema functools32 09:39:32 INFO - Cleaning up... 09:39:32 INFO - Return code: 0 09:39:32 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:39:32 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')]} 09:39:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:39:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:32 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')]} 09:39:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:39:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:32 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 0x1dd3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2002400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2091570>, '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 0x2092470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2092900>, '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': '6dbc10da6d83fee962c624be000001a8-1474302692.58684-1942397390', '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 09:39:32 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 09:39:32 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 09:39:32 INFO - Using env: {'DISPLAY': ':0', 09:39:32 INFO - 'HOME': '/home/cltbld', 09:39:32 INFO - 'LANG': 'en_US.UTF-8', 09:39:32 INFO - 'LANGUAGE': 'en_US:en', 09:39:32 INFO - 'LOGNAME': 'cltbld', 09:39:32 INFO - 'MAIL': '/var/mail/cltbld', 09:39:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:39:32 INFO - 'MOZ_NO_REMOTE': '1', 09:39:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:39:32 INFO - 'NO_EM_RESTART': '1', 09:39:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:39:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:39:32 INFO - 'PWD': '/builds/slave/test', 09:39:32 INFO - 'SHELL': '/bin/bash', 09:39:32 INFO - 'SHLVL': '1', 09:39:32 INFO - 'TERM': 'linux', 09:39:32 INFO - 'TMOUT': '86400', 09:39:32 INFO - 'USER': 'cltbld', 09:39:32 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1474302692.58684-1942397390', 09:39:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:39:32 INFO - '_': '/tools/buildbot/bin/python'} 09:39:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:39:33 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:39:33 INFO - Cleaning up... 09:39:33 INFO - Return code: 0 09:39:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:39:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:39:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:39:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:39:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:39:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:33 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 0x1dd3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2002400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2091570>, '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 0x2092470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2092900>, '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': '6dbc10da6d83fee962c624be000001a8-1474302692.58684-1942397390', '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 09:39:33 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 09:39:33 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 09:39:33 INFO - Using env: {'DISPLAY': ':0', 09:39:33 INFO - 'HOME': '/home/cltbld', 09:39:33 INFO - 'LANG': 'en_US.UTF-8', 09:39:33 INFO - 'LANGUAGE': 'en_US:en', 09:39:33 INFO - 'LOGNAME': 'cltbld', 09:39:33 INFO - 'MAIL': '/var/mail/cltbld', 09:39:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:39:33 INFO - 'MOZ_NO_REMOTE': '1', 09:39:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:39:33 INFO - 'NO_EM_RESTART': '1', 09:39:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:39:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:39:33 INFO - 'PWD': '/builds/slave/test', 09:39:33 INFO - 'SHELL': '/bin/bash', 09:39:33 INFO - 'SHLVL': '1', 09:39:33 INFO - 'TERM': 'linux', 09:39:33 INFO - 'TMOUT': '86400', 09:39:33 INFO - 'USER': 'cltbld', 09:39:33 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1474302692.58684-1942397390', 09:39:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:39:33 INFO - '_': '/tools/buildbot/bin/python'} 09:39:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:39:33 INFO - Downloading/unpacking blobuploader==1.2.4 09:39:33 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 09:39:33 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 09:39:33 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 09:39:33 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 09:39:33 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 09:39:33 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 09:39:35 INFO - Downloading blobuploader-1.2.4.tar.gz 09:39:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:39:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:39:35 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 09:39:35 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 09:39:35 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 09:39:35 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 09:39:35 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 09:39:35 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 09:39:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:39:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:39:35 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 09:39:35 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 09:39:35 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 09:39:35 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 09:39:35 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 09:39:35 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 09:39:35 INFO - Downloading docopt-0.6.1.tar.gz 09:39:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:39:36 INFO - Installing collected packages: blobuploader, requests, docopt 09:39:36 INFO - Running setup.py install for blobuploader 09:39:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:39:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:39:36 INFO - Running setup.py install for requests 09:39:36 INFO - Running setup.py install for docopt 09:39:36 INFO - Successfully installed blobuploader requests docopt 09:39:36 INFO - Cleaning up... 09:39:36 INFO - Return code: 0 09:39:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:39:36 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')]} 09:39:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:39:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:36 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')]} 09:39:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:39:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:36 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 0x1dd3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2002400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2091570>, '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 0x2092470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2092900>, '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': '6dbc10da6d83fee962c624be000001a8-1474302692.58684-1942397390', '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 09:39:36 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 09:39:36 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 09:39:36 INFO - Using env: {'DISPLAY': ':0', 09:39:36 INFO - 'HOME': '/home/cltbld', 09:39:36 INFO - 'LANG': 'en_US.UTF-8', 09:39:36 INFO - 'LANGUAGE': 'en_US:en', 09:39:36 INFO - 'LOGNAME': 'cltbld', 09:39:36 INFO - 'MAIL': '/var/mail/cltbld', 09:39:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:39:36 INFO - 'MOZ_NO_REMOTE': '1', 09:39:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:39:36 INFO - 'NO_EM_RESTART': '1', 09:39:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:39:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:39:36 INFO - 'PWD': '/builds/slave/test', 09:39:36 INFO - 'SHELL': '/bin/bash', 09:39:36 INFO - 'SHLVL': '1', 09:39:36 INFO - 'TERM': 'linux', 09:39:36 INFO - 'TMOUT': '86400', 09:39:36 INFO - 'USER': 'cltbld', 09:39:36 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1474302692.58684-1942397390', 09:39:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:39:36 INFO - '_': '/tools/buildbot/bin/python'} 09:39:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:39:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:39:36 INFO - Running setup.py (path:/tmp/pip-wk0DPV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:39:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:39:36 INFO - Running setup.py (path:/tmp/pip-Bm90iC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:39:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:39:37 INFO - Running setup.py (path:/tmp/pip-H7Viky-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:39:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:39:37 INFO - Running setup.py (path:/tmp/pip-dQcocH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:39:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:39:37 INFO - Running setup.py (path:/tmp/pip-RBsu_0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:39:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:39:37 INFO - Running setup.py (path:/tmp/pip-vk6sId-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:39:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:39:37 INFO - Running setup.py (path:/tmp/pip-M3u08Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:39:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:39:37 INFO - Running setup.py (path:/tmp/pip-PDoQw4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:39:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:39:37 INFO - Running setup.py (path:/tmp/pip-Obi9KJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:39:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:39:37 INFO - Running setup.py (path:/tmp/pip-mDeDi_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:39:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:39:37 INFO - Running setup.py (path:/tmp/pip-CpCqGM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:39:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:39:37 INFO - Running setup.py (path:/tmp/pip-OFY3tC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:39:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:39:37 INFO - Running setup.py (path:/tmp/pip-WXxiPD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:39:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:39:37 INFO - Running setup.py (path:/tmp/pip-exAank-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:39:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:39:37 INFO - Running setup.py (path:/tmp/pip-InfAsy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:39:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:39:37 INFO - Running setup.py (path:/tmp/pip-EFAFQ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:39:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:39:38 INFO - Running setup.py (path:/tmp/pip-z7hXUa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:39:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:39:38 INFO - Running setup.py install for manifestparser 09:39:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:39:38 INFO - Running setup.py install for mozcrash 09:39:38 INFO - Running setup.py install for mozdebug 09:39:38 INFO - Running setup.py install for mozdevice 09:39:38 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:39:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:39:38 INFO - Running setup.py install for mozfile 09:39:38 INFO - Running setup.py install for mozhttpd 09:39:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:39:38 INFO - Running setup.py install for mozinfo 09:39:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:39:38 INFO - Running setup.py install for mozInstall 09:39:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:39:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:39:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:39:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:39:38 INFO - Running setup.py install for mozleak 09:39:38 INFO - Running setup.py install for mozlog 09:39:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:39:39 INFO - Running setup.py install for moznetwork 09:39:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:39:39 INFO - Running setup.py install for mozprocess 09:39:39 INFO - Running setup.py install for mozprofile 09:39:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:39:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:39:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:39:39 INFO - Running setup.py install for mozrunner 09:39:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:39:39 INFO - Running setup.py install for mozscreenshot 09:39:39 INFO - Running setup.py install for moztest 09:39:39 INFO - Running setup.py install for mozversion 09:39:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:39:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:39:39 INFO - Cleaning up... 09:39:39 INFO - Return code: 0 09:39:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:39:39 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')]} 09:39:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:39:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:39 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')]} 09:39:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:39:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:39 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 0x1dd3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2002400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2091570>, '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 0x2092470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2092900>, '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': '6dbc10da6d83fee962c624be000001a8-1474302692.58684-1942397390', '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 09:39:39 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 09:39:39 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 09:39:39 INFO - Using env: {'DISPLAY': ':0', 09:39:39 INFO - 'HOME': '/home/cltbld', 09:39:39 INFO - 'LANG': 'en_US.UTF-8', 09:39:39 INFO - 'LANGUAGE': 'en_US:en', 09:39:39 INFO - 'LOGNAME': 'cltbld', 09:39:39 INFO - 'MAIL': '/var/mail/cltbld', 09:39:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:39:39 INFO - 'MOZ_NO_REMOTE': '1', 09:39:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:39:39 INFO - 'NO_EM_RESTART': '1', 09:39:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:39:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:39:39 INFO - 'PWD': '/builds/slave/test', 09:39:39 INFO - 'SHELL': '/bin/bash', 09:39:39 INFO - 'SHLVL': '1', 09:39:39 INFO - 'TERM': 'linux', 09:39:39 INFO - 'TMOUT': '86400', 09:39:39 INFO - 'USER': 'cltbld', 09:39:39 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1474302692.58684-1942397390', 09:39:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:39:39 INFO - '_': '/tools/buildbot/bin/python'} 09:39:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:39:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:39:40 INFO - Running setup.py (path:/tmp/pip-YqsRg5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:39:40 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)) 09:39:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:39:40 INFO - Running setup.py (path:/tmp/pip-AVI_zi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:39:40 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)) 09:39:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:39:40 INFO - Running setup.py (path:/tmp/pip-rdPCex-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:39:40 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)) 09:39:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:39:40 INFO - Running setup.py (path:/tmp/pip-7wPqcV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:39:40 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)) 09:39:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:39:40 INFO - Running setup.py (path:/tmp/pip-B9fQym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:39:40 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)) 09:39:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:39:40 INFO - Running setup.py (path:/tmp/pip-RUY5P2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:39:40 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)) 09:39:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:39:40 INFO - Running setup.py (path:/tmp/pip-d_oMr_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:39:40 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)) 09:39:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:39:40 INFO - Running setup.py (path:/tmp/pip-2YExNp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:39:40 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)) 09:39:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:39:40 INFO - Running setup.py (path:/tmp/pip-i8aj9p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:39:40 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)) 09:39:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:39:40 INFO - Running setup.py (path:/tmp/pip-FGYAT3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:39:40 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)) 09:39:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:39:40 INFO - Running setup.py (path:/tmp/pip-GIJTub-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:39:40 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)) 09:39:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:39:40 INFO - Running setup.py (path:/tmp/pip-TO8ePY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:39:40 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)) 09:39:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:39:41 INFO - Running setup.py (path:/tmp/pip-4z3jwh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:39:41 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)) 09:39:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:39:41 INFO - Running setup.py (path:/tmp/pip-s2lVPJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:39:41 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)) 09:39:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:39:41 INFO - Running setup.py (path:/tmp/pip-a81_YS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:39:41 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)) 09:39:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:39:41 INFO - Running setup.py (path:/tmp/pip-hH0fOx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:39:41 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)) 09:39:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:39:41 INFO - Running setup.py (path:/tmp/pip-z4WUkG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:39:41 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)) 09:39:41 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)) 09:39:41 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)) 09:39:41 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)) 09:39:41 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)) 09:39:41 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)) 09:39:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:39: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 09:39: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 09:39: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 09:39: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 09:39: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 09:39: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 09:39:43 INFO - Downloading blessings-1.6.tar.gz 09:39:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:39:43 INFO - Installing collected packages: blessings 09:39:43 INFO - Running setup.py install for blessings 09:39:43 INFO - Successfully installed blessings 09:39:43 INFO - Cleaning up... 09:39:43 INFO - Return code: 0 09:39:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:39:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:39:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:39:43 INFO - Reading from file tmpfile_stdout 09:39:43 INFO - Current package versions: 09:39:43 INFO - argparse == 1.2.1 09:39:43 INFO - blessings == 1.6 09:39:43 INFO - blobuploader == 1.2.4 09:39:43 INFO - docopt == 0.6.1 09:39:43 INFO - functools32 == 3.2.3-2 09:39:43 INFO - jsonschema == 2.5.1 09:39:43 INFO - manifestparser == 1.1 09:39:43 INFO - mozInstall == 1.12 09:39:43 INFO - mozcrash == 0.17 09:39:43 INFO - mozdebug == 0.1 09:39:43 INFO - mozdevice == 0.48 09:39:43 INFO - mozfile == 1.2 09:39:43 INFO - mozhttpd == 0.7 09:39:43 INFO - mozinfo == 0.9 09:39:43 INFO - mozleak == 0.1 09:39:43 INFO - mozlog == 3.3 09:39:43 INFO - moznetwork == 0.27 09:39:43 INFO - mozprocess == 0.23 09:39:43 INFO - mozprofile == 0.28 09:39:43 INFO - mozrunner == 6.12 09:39:43 INFO - mozscreenshot == 0.1 09:39:43 INFO - mozsystemmonitor == 0.3 09:39:43 INFO - moztest == 0.7 09:39:43 INFO - mozversion == 1.4 09:39:43 INFO - psutil == 3.1.1 09:39:43 INFO - requests == 1.2.3 09:39:43 INFO - wsgiref == 0.1.2 09:39:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:39: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')]} 09:39:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:39:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39: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')]} 09:39:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:39:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:43 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 0x1dd3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2002400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2091570>, '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 0x2092470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2092900>, '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': '6dbc10da6d83fee962c624be000001a8-1474302692.58684-1942397390', '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 09:39:43 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 09:39:43 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 09:39:43 INFO - Using env: {'DISPLAY': ':0', 09:39:43 INFO - 'HOME': '/home/cltbld', 09:39:43 INFO - 'LANG': 'en_US.UTF-8', 09:39:43 INFO - 'LANGUAGE': 'en_US:en', 09:39:43 INFO - 'LOGNAME': 'cltbld', 09:39:43 INFO - 'MAIL': '/var/mail/cltbld', 09:39:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:39:43 INFO - 'MOZ_NO_REMOTE': '1', 09:39:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:39:43 INFO - 'NO_EM_RESTART': '1', 09:39:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:39:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:39:43 INFO - 'PWD': '/builds/slave/test', 09:39:43 INFO - 'SHELL': '/bin/bash', 09:39:43 INFO - 'SHLVL': '1', 09:39:43 INFO - 'TERM': 'linux', 09:39:43 INFO - 'TMOUT': '86400', 09:39:43 INFO - 'USER': 'cltbld', 09:39:43 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1474302692.58684-1942397390', 09:39:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:39:43 INFO - '_': '/tools/buildbot/bin/python'} 09:39:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:39:43 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)) 09:39:43 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)) 09:39:43 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)) 09:39:43 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)) 09:39:43 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)) 09:39:43 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)) 09:39:43 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)) 09:39:43 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)) 09:39:43 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)) 09:39:43 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)) 09:39:43 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)) 09:39:43 INFO - Cleaning up... 09:39:43 INFO - Return code: 0 09:39:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:39: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')]} 09:39:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:39:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39: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')]} 09:39:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:39:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39: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']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2002400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2091570>, '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 0x2092470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2092900>, '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': '6dbc10da6d83fee962c624be000001a8-1474302692.58684-1942397390', '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 09:39: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'] in /builds/slave/test/build 09:39: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 09:39:43 INFO - Using env: {'DISPLAY': ':0', 09:39:43 INFO - 'HOME': '/home/cltbld', 09:39:43 INFO - 'LANG': 'en_US.UTF-8', 09:39:43 INFO - 'LANGUAGE': 'en_US:en', 09:39:43 INFO - 'LOGNAME': 'cltbld', 09:39:43 INFO - 'MAIL': '/var/mail/cltbld', 09:39:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:39:43 INFO - 'MOZ_NO_REMOTE': '1', 09:39:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:39:43 INFO - 'NO_EM_RESTART': '1', 09:39:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:39:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:39:43 INFO - 'PWD': '/builds/slave/test', 09:39:43 INFO - 'SHELL': '/bin/bash', 09:39:43 INFO - 'SHLVL': '1', 09:39:43 INFO - 'TERM': 'linux', 09:39:43 INFO - 'TMOUT': '86400', 09:39:43 INFO - 'USER': 'cltbld', 09:39:43 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1474302692.58684-1942397390', 09:39:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:39:43 INFO - '_': '/tools/buildbot/bin/python'} 09:39:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:39:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:39:44 INFO - Cleaning up... 09:39:44 INFO - Return code: 0 09:39:44 INFO - Running post-action listener: _resource_record_post_action 09:39:44 INFO - Running post-action listener: _start_resource_monitoring 09:39:44 INFO - Starting resource monitoring. 09:39:44 INFO - [mozharness: 2016-09-19 16:39:44.186721Z] Finished create-virtualenv step (success) 09:39:44 INFO - [mozharness: 2016-09-19 16:39:44.187196Z] Running install step. 09:39:44 INFO - Running pre-action listener: _resource_record_pre_action 09:39:44 INFO - Running main action method: install 09:39:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:39:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:39:44 INFO - Reading from file tmpfile_stdout 09:39:44 INFO - Detecting whether we're running mozinstall >=1.0... 09:39:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:39:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:39:44 INFO - Reading from file tmpfile_stdout 09:39:44 INFO - Output received: 09:39:44 INFO - Usage: mozinstall [options] installer 09:39:44 INFO - Options: 09:39:44 INFO - -h, --help show this help message and exit 09:39:44 INFO - -d DEST, --destination=DEST 09:39:44 INFO - Directory to install application into. [default: 09:39:44 INFO - "/builds/slave/test"] 09:39:44 INFO - --app=APP Application being installed. [default: firefox] 09:39:44 INFO - mkdir: /builds/slave/test/build/application 09:39:44 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'] 09:39:44 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 09:39:58 INFO - Reading from file tmpfile_stdout 09:39:58 INFO - Output received: 09:39:58 INFO - /builds/slave/test/build/application/firefox/firefox 09:39:58 INFO - Running post-action listener: _resource_record_post_action 09:39:58 INFO - [mozharness: 2016-09-19 16:39:58.550236Z] Finished install step (success) 09:39:58 INFO - [mozharness: 2016-09-19 16:39:58.550516Z] Running run-tests step. 09:39:58 INFO - Running pre-action listener: _resource_record_pre_action 09:39:58 INFO - Running main action method: run_tests 09:39:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:39:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:39:58 INFO - Python 2.7.3 09:39:58 INFO - Return code: 0 09:39:58 INFO - grabbing minidump binary from tooltool 09:39: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')]} 09:39:58 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 0x2091570>, '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 0x2092470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2092900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:39:58 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 09:39:58 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 09:39:58 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 09:39:58 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:39:58 INFO - Return code: 0 09:39:58 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:39:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:39:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:39:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:39:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:39:58 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/NP4rm_HuS0OWUwXOhIFq3A/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 09:39:58 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/NP4rm_HuS0OWUwXOhIFq3A/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-050 --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 09:39:58 INFO - Using env: {'DISPLAY': ':0', 09:39:58 INFO - 'HOME': '/home/cltbld', 09:39:58 INFO - 'LANG': 'en_US.UTF-8', 09:39:58 INFO - 'LANGUAGE': 'en_US:en', 09:39:58 INFO - 'LOGNAME': 'cltbld', 09:39:58 INFO - 'MAIL': '/var/mail/cltbld', 09:39:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:39:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:39:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:39:58 INFO - 'MOZ_NO_REMOTE': '1', 09:39:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:39:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:39:58 INFO - 'NO_EM_RESTART': '1', 09:39:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:39:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:39:58 INFO - 'PWD': '/builds/slave/test', 09:39:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:39:58 INFO - 'SHELL': '/bin/bash', 09:39:58 INFO - 'SHLVL': '1', 09:39:58 INFO - 'TERM': 'linux', 09:39:58 INFO - 'TMOUT': '86400', 09:39:58 INFO - 'USER': 'cltbld', 09:39:58 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1474302692.58684-1942397390', 09:39:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:39:58 INFO - '_': '/tools/buildbot/bin/python'} 09:39:58 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/NP4rm_HuS0OWUwXOhIFq3A/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 09:39:58 INFO - mozversion application_buildid: 20160919064031 09:39:58 INFO - mozversion application_changeset: 01d67bfe6c8198416ec190cbc216d953c1625b94 09:39:58 INFO - mozversion application_display_name: Firefox 09:39:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:39:58 INFO - mozversion application_name: Firefox 09:39:58 INFO - mozversion application_remotingname: firefox 09:39:58 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 09:39:58 INFO - mozversion application_vendor: Mozilla 09:39:58 INFO - mozversion application_version: 50.0 09:39:58 INFO - mozversion platform_buildid: 20160919064031 09:39:58 INFO - mozversion platform_changeset: 01d67bfe6c8198416ec190cbc216d953c1625b94 09:39:58 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 09:39:58 INFO - mozversion platform_version: 50.0 09:39:58 INFO - using testdate: 1474303198 09:39:58 INFO - actual date: 1474303198 09:39:58 INFO - starting webserver on 'localhost:56791' 09:39:58 INFO - SUITE-START | Running 2 tests 09:39:58 INFO - TEST-START | dromaeo_css 09:39:58 INFO - operating with platform_type : linux_ 09:39:58 INFO - Initialising browser for dromaeo_css test... 09:39:58 INFO - TEST-INFO | started process 18526 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDUaDW3/profile http://localhost:56791/getInfo.html) 09:40:03 INFO - PROCESS | 18526 | __metrics Screen width/height:1600/1200 09:40:03 INFO - PROCESS | 18526 | colorDepth:24 09:40:03 INFO - PROCESS | 18526 | Browser inner width/height: 1024/697 09:40:03 INFO - PROCESS | 18526 | __metrics 09:40:03 ERROR - PROCESS | 18526 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 09:40:04 INFO - TEST-INFO | 18526: exit 0 09:40:04 INFO - Browser initialized. 09:40:04 INFO - Running cycle 1/1 for dromaeo_css test... 09:40:04 INFO - TEST-INFO | started process 18652 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDUaDW3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:40:16 INFO - PROCESS | 18652 | RSS: Main: 149905408 09:40:16 INFO - PROCESS | 18652 | 09:41:06 INFO - PROCESS | 18652 | 1474303266029 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] 09:43:14 INFO - PROCESS | 18652 | Cycle 1(1): loaded http://localhost:56791/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56791/tests/dromaeo/cssquery-ext.html) 09:43:15 INFO - PROCESS | 18652 | RSS: Main: 158236672 09:43:15 INFO - PROCESS | 18652 | 09:46:17 INFO - PROCESS | 18652 | Cycle 1(1): loaded http://localhost:56791/tests/dromaeo/cssquery-ext.html (next: http://localhost:56791/tests/dromaeo/cssquery-jquery.html) 09:46:18 INFO - PROCESS | 18652 | RSS: Main: 155734016 09:46:18 INFO - PROCESS | 18652 | 09:49:20 INFO - PROCESS | 18652 | Cycle 1(1): loaded http://localhost:56791/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56791/tests/dromaeo/cssquery-mootools.html) 09:49:20 INFO - PROCESS | 18652 | RSS: Main: 155017216 09:49:20 INFO - PROCESS | 18652 | 09:52:22 INFO - PROCESS | 18652 | Cycle 1(1): loaded http://localhost:56791/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56791/tests/dromaeo/cssquery-prototype.html) 09:52:23 INFO - PROCESS | 18652 | RSS: Main: 156835840 09:52:23 INFO - PROCESS | 18652 | 09:55:25 INFO - PROCESS | 18652 | Cycle 1(1): loaded http://localhost:56791/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56791/tests/dromaeo/cssquery-yui.html) 09:55:25 INFO - PROCESS | 18652 | RSS: Main: 157429760 09:55:25 INFO - PROCESS | 18652 | 09:58:28 INFO - PROCESS | 18652 | Cycle 1(1): loaded http://localhost:56791/tests/dromaeo/cssquery-yui.html (next: http://localhost:56791/tests/dromaeo/cssquery-dojo.html) 09:58:28 INFO - PROCESS | 18652 | RSS: Main: 157544448 09:58:28 INFO - PROCESS | 18652 | 09:58:28 INFO - PROCESS | 18652 | __start_tp_report 09:58:28 INFO - PROCESS | 18652 | _x_x_mozilla_page_load 09:58:28 INFO - PROCESS | 18652 | _x_x_mozilla_page_load_details 09:58:28 INFO - PROCESS | 18652 | |i|pagename|runs| 09:58:28 INFO - PROCESS | 18652 | |0;dojo.html;3301.8349082545874;3332.3168750406153;3336.932181701856;3352.4971254311868;3362.882299119531;5735.7705691772335;5792.826215213539;5815.796447124351;5820.38885916979;5822.155787410823;5820.214271073404;5883.823485295437;5896.174535565025;5903.4391732785425;5922.2597175353085;5299.920501192485;5357.651752636086;5380.515753582196;5405.783768649249;5456.208849716809;5279.287296215;5282.154855223165;5292.550133238679;5323.494268044549;5348.839534813962;5356.276902618155;5371.355437347524;5388.084025715618;5438.592105592076;5440.483154100354;5413.188021796742;5415.756290966916;5419.5393391561565;5424.0236757383655;5428.0500912340185;5156.149235376159;5191.039657663345;5270.578353731692;5349.3045904032615;5453.809116680937;5693.857653558653;5772.624779389326;5815.127730840365;5829.183914252008;5832.358440571534;6226.066090086478;6269.122322874801;6286.528510361695;6294.87410251797;6316.778912738078;6079.513638908877;6138.2964379703635;6299.496040316763;6327.430531252209;6353.30113687494;5772.30732312121;5871.383504731984;5875.676837773878;5896.469317761379;5911.9113213301835;6401.9039714404325;6403.167588213596;6415;6442.259140198843;6457.838554036092;6033.155358249848;6064.48451881595;6171.876562468726;6184.81445556634;6198.597091189058;6127.295361033449;6210.968945155245;6236.376362363818;6236.781712640036;6237.688115594202;6175.2589689237575;6201.131841542187;6206;6207.441330280297;6224.782132625336;6069.787557435468;6091.9695401523595;6193.071039344044;6195.690215489208;6201.565890387629;4656.32483289921;4771.355866957986;4775.928361074587;4803.159447096744;4806.086843499724;4231.7672528010635;4246.660267178619;4246.723962942398;4266;4279.828806847691;5872.559558033079;5928.9407105928385;5993.820185394445;6057.3336932937345;6065.969670151621;6199.194104766441;6307.274663413675;6321.336259692758;6322.620642761357;6332.873342533124;6029.216201893726;6036.879262414815;6062.696865156725;6074.362191969868;6096.177016102858;5263.315768950089;5327.413984461706;5378.596605254622;5422.53908417781;5426.077566813651;6367.904481432783;6518.608883467007;6518.934810651927;6525.1517302750335;6531.0856480092825;6319.273283572448;6335.90496142549;6348.999999999907;6350.7777227796805;6352.968235158794;6280.057991301342;6367.713452894724;6475.902861457176;6475.935240647534;6538.934610653832;6100.816975490742;6211.81364559064;6213;6214.036824292242;6214.5028397727165;6277.435030847246;6307.716152773044;6322.841928951813;6325.209348831396;6338.207724034496;6030.517558595389;6061.181740464981;6155.230596175478;6165.32181460048;6180.381961803783;6059.848503787441;6122;6151.96924015377;6161.353057929032;6169.907451388322;6117.694115294128;6118.284172697687;6124.050772130327;6125.378848301115;6137.120988813815;5998.070299103646;6099.054646529795;6158.230221222348;6177.84555386119;6195.411435913581;5907.645541267538;5985.25184351956;6009.789657361971;6039.245094363205;6047.244094488189 09:58:28 INFO - PROCESS | 18652 | |1;ext.html;577.6591810831611;639.6481934935784;655.2955572759284;656.4059526128852;692.9896051559231;40963.18073638529;45534.08931821366;45879.54120458794;45884.08231835361;45993.7700311498;46492.767536162275;46646.300305495446;46926.29610555836;47063.52936470643;47070.76464617681;8936.91063089369;9123.087691230858;9140.954295228514;9145.176934075931;9158.129977652112;9114.088591140866;9169.816603667923;9193;9195.12646298604;9226.907730922672;9205.447673139599;9205.861912071325;9219.308551858603;9236.491992940419;9249.35254532183;9165.816683666322;9165.908340916605;9170.312226582999;9191.586378612978;9207.217386522154;9026.277897768228;9070.365074444791;9121.589528471235;9148.2681385489;9148.8627670585;44255.77872110651;44748.3287750684;44766;44786;45001.324980125326;3415.9658403416147;3727.5340582427198;3730.0301921500604;4037.6366127048414;4230.661547076226;35277.29445411077;35613.46579801305;35970.820145899364;36558;36856.44715329272;4659.790309436084;4702.647301452371;4729.432468103815;4794.9280760788615;4813.951860481386;404079;406380.9680951606;409263;409414;409466;67659.32340676629;67781.66109169522;67955;68126.31873681299;68203;39883.80058099749;70912;71006.289937101;71013.64493177501;71162.64418677977;19218.4234472966;19570.21719131219;19598.21607135727;19624;19687.40937771869;15119.244037798066;15269.847301527065;15286.159261240517;15295.770563441558;15300.311485983157;20811.375658730263;21063.78936210649;21100.155993760076;21113.049912753962;21159.25942592002;7241.674124664402;7345.816354591178;7404.1855395906405;7411.6664750086375;7741.264579864904;1028.7993841200894;1128.8927551882557;1143.5128595305177;1158.9478473468714;1187.5487314820314;33499.16252093668;33663.66336336654;34002.14994625154;34397;34492.655073449445;1156.4853640130061;1157.4685107803025;1189.690680423079;1209.4013463335705;1239.6838806104565;17907.462776116736;18052.458426247234;18110;18138.274469021355;18160.455186344432;625421;625699;626721;631660;633432;65376.34623653703;65529.344706553275;65642.67178664076;65649.35876603123;65982.34017659858;1449.6303442622275;1460.9634759131106;1477.6379786952266;1481.7406953783045;1482.6219314075058;33245.16887077746;33699;33756.3248735019;33965.49051764275;33982.209360720655;56805.71597141988;56958.430415695315;57059.71470142789;57250.42749572617;57416.71291643682;501825;513430;517877;517995;520079;31760;32083.518747218342;32115.67884321127;32139.839300803345;32322.676773231968;53319.73340133274;53557.464425356804;54335.184972224655;55134;55529.16706249329;44756.71703303452;44935.29385403653;46183.76908115438;47043.76478117587;47766.52233477621;45868.54131458776;45924.311135332326;46222.53777462317;46304.53695463002;46706.29940550827;44747.55252447434;45431.772841135586;45552.316715248635;46172.538274618164;48794;39449;40271.1945761089;40787;40827.38758918559;41411.585884140775;29933.401331973673;30221.69778302189;30441.39117217599;30461.847690761406;30775.692243077283 09:58:28 INFO - PROCESS | 18652 | |2;jquery.html;421.4451490109634;429.8474041715193;431.2410158121705;444.1450208348929;448.33422367783857;19438;20601.38195854123;21082.262120825773;21139.04874280657;21193.364199074014;19587.608247835036;20120.295789647364;20139.899300503515;20457.386278411635;20505.179792808307;5818.505427038696;6019.367966363535;6027.588964414225;6028.788992385267;6036.3661815509395;5621.943780562183;5829.621074630157;5874.647521148745;5882.823515294526;5990.341062483145;5878.441548052928;5878.764849406019;5911.083782013795;5952.464278214959;6349.365063493637;6388.520860935425;6568.737250509974;6681.1314529110905;6699.799006029827;6723.193216813965;5816.243888294537;5973.8207853764025;5995.010823214165;6003.489703375219;6018.879622407571;14280.714385712228;14502.41990320386;14542.927285363505;14721.263936803223;14744.631384215374;2473.4063824682125;2518.874056297196;2567.56351420259;2607.478504299148;2611.6213149093273;10096.4694181999;10937.289076210021;12646.367681615882;14989.550313490612;15793;1947.191915355126;1975.9209631614717;2033.2680235115347;2033.6339458897392;2059.9176032958662;89139.55430222872;90135.54932225363;91897;92989;93024;10977.83533247002;11280.379579123228;11413.144014198968;11960.760784784256;11997.820032699516;17210.225539850737;17240;17257;17297.308107675803;17363.47909562715;8181;8362.247397734232;8532.616032278562;8589.098144694717;8683.52240626759;7138.500304978706;7208;7270.672819723125;7497.812554686177;7543.358814500719;4877.561019508261;4961.479044700254;5034.270030845507;5145.202493613496;5230.712310822865;2016.8890711010743;2029.604227175716;2065.215218217098;2077.2833372486466;2115.111653105699;939.8073394954018;1063.9468026598795;1077.4074259157433;1104.7151023966894;1118.4016551145098;20151.08574165761;20401.183952641728;20512.179512819617;20622.690659640117;20991.370258892257;1026.8870424253325;1046.398320965448;1059.9788004240027;1061.0821639281965;1092.6175838456636;10711.625093121704;11512.251703639236;11574.88425115755;11579.363135027654;11586.942065289788;513714;520985;523668;526985;544863;93889.53055234817;95253.5237323809;96380.51809741047;101804;103481.48259258656;1086.5165001574383;1089.2538611051455;1113.1818113686595;1118.2563595209258;1121.9046381057537;18417.447476575726;18739.625207496047;19124.521886952938;19202;19551;40848;41623.87355885458;45542;46884;47054.294185587925;60694.393056068875;61315;61566.69216653888;62463.37536624575;63248.78629248138;8435.156484351515;8637.956810215908;8910.688125915822;8933.642654294015;9020.188183063556;11045.613403530839;12850.742985140432;13283.800742989057;13357.332133393096;13607;11640.592579259684;11715;12057.276563405872;12097.939510302744;12099.274043557414;11475.081993440337;11575.594854180063;11641.126915481542;11722.76554468923;11966.521339146684;11632.127590430582;11785;11859.881401185878;11944.16390852632;12037;7916.406269529693;8133.674653013813;8156.632951517077;8556.930383702038;9128.269738420777;11798;11875.76248475043;12096.092793040381;12221.388930553614;12400.069994750249 09:58:28 INFO - PROCESS | 18652 | |3;mootools.html;1520.9011414258075;1550.565841564362;1684.9915750421246;1801.9639607207848;1809.6742586334462;8561.143885611436;8977.820443591125;9249.53752312385;9629.181519570837;9650.034996500346;9237.76905577361;9576;9596.28027897907;9605.903940960588;9606;2539.746025397459;2574.5365834149848;2585.58630619101;2586.9094581689646;2590.4689538644625;2452.583060879646;2567.550678631241;2567.884445199961;2569.267758688774;2570.9973110486926;2567.512172687193;2578.9097381591646;2604.1536500637276;2606.9217923462325;2609.3737502999334;2522.2433270019014;2530;2534.9112781052577;2536.074332868508;2559.897604095834;2461.4707837814954;2479.7148327942336;2482.8386154900054;2483.0936708101594;2496.5506208882393;9715.757106072335;9798.069183427562;9807.90192098077;9826.606935722562;9828.361156524803;5625.268715067056;5794.50746686528;5870.853228669274;5896.233489646319;5901.114832775118;3465.6707612776745;3606.7294952878638;3630.2195028068827;3638.072291565634;3680.2087551176623;1186.9465874035689;1258.245052968221;1261.6719652890222;1273.5606215855514;1281.9807702884464;12706.74586508274;13033.869661303455;13055.151415157985;13448.125871818398;13706.38321275545;4938.8271410501175;4949.307097006422;4953.083679519301;5023.045621331935;5074.467180945948;10128.949355253177;10139.239557033252;10149.035841595036;10159.644412445678;10161.898381016243;5799.18811366409;5820.30156381237;5828.038373668382;5830.883382332329;5839.795607153814;5195.584353251731;5371.838844834661;5374.27447294618;5434.972825135849;5476.534494567926;4252.4046633471335;4309.806058727365;4328.870133895988;4332.891677708082;4347.500037495665;1268.9555865544846;1271.8728127187208;1282.7113899372566;1291.1284882704138;1297.4096785962365;932;964.1322809471392;980.1766516126488;984.2372161574693;1024.2522958240527;6101.420365065312;6143.938560614337;6447.6131432114225;6468.029795530708;6513.674316284261;994.5226291380178;1042.4475028235047;1058.9311694739818;1062.442217835627;1069.909057730086;4359.38968544404;4486.304622783474;4545.681802273809;4551.977240113778;4578.519255478127;11964.341961192044;12203.389830508439;12216.938915305544;12325;12342.321172335429;11275.492602832892;11604.6518604442;11680.182387232982;11997.460114294878;12184;8911.688090916787;9092.272618190662;9097.81728375307;9117.680881169259;9158.67944621935;6161.537884658579;6427.164468619049;6779.72881084751;6780.898286525608;6846;10677;11147.609833655782;11160.888391115985;11222;11284.153688473232;11115.722106947067;11153.888461115284;11235.15736319763;11291.43542822872;11406.315621062762;7991.760247192594;8056.677732890619;8202.179782021989;8306.377021723516;8343.874841877498;9557.99641037681;9602.711918642452;9630.614775408905;9649.228061755182;9652.951735241279;8074.677012919417;8359.874601881098;8428.831423371621;8453.154684531497;8475.660973560989;8429.114942930904;8449.66201351939;8488.74533763988;8488.915110849059;8518.829623407373;7340.669669864762;7424.665890035069;7497.962510187414;7502.662380192795;7525.661345239587;5459.481349271813;5484.396716361117;5597.972010139923;5610.102383618601;5737.827865164052;5574.024545704405;5715.542756579547;5778.133280007864;5784;5796.94203057964 09:58:28 INFO - PROCESS | 18652 | |4;prototype.html;339.960904495983;343.9363717712225;344.0401280427607;346.66546782355033;347.9286746217025;5870.559708021894;5895.555588880725;5917.585768996167;5954.31525374581;5967.641941483508;5756.769729210827;5780.4219578042175;5787.353967000794;5791.623544469607;5849.952516619182;4528.524504926968;4539.954600453994;4545.272756358983;4559.74921379324;4594.540545945412;4437.511873693891;4538.636909047268;4539.477960034589;4548.999220171557;4594;4474.7023363224625;4481.327800829886;4482.820687172509;4483.968687201946;4487.259602165639;4493.236149854532;4506.414166158394;4526.615237704799;4527.366168736379;4573.611243044345;3829.4064420014943;3883.6601372526716;3938.4289278054807;3982.960170398288;3988.4216788565786;5641.492265696107;5653.745581448845;5656.745446454919;5657.896710141524;5726.141078838166;5131.179011358165;5138.177891537373;5139.3040296702375;5151.974240128776;5186.429492755794;5865.824025279248;6125.816225513242;6135.32511423743;6137.171481849938;6229.37706229378;4329.328954012133;4349.9130017399475;4375.7374557526655;4401.515833258339;4402.647788176938;6275.7175927083845;6418.839529011765;6447.903281450782;6489.610623362613;6515.837104072389;4398.582134697199;4398.714083584557;4401.383806267125;4419.668524860648;4423.712458690175;4456.68803183774;4469.039156581351;4482.260427029569;4504.166729155117;4524.959259370363;5211.635185536976;5220.843374698765;5229.215617657305;5243.4232234454175;5258.290130832365;5866.70666466675;6029.8191054268445;6052.364501727343;6165.8458538536;6175.258968923668;1524.7179271834525;1540.9691806163814;1553.6814952934621;1558.883083768722;1560.9141497217536;967.9274054445804;980.9166220871164;980.9411435313904;985.5811280205884;996.5864166371019;5256.448072952361;5259.447757985433;5272.604554658339;5278.8944221116135;5285.207218917117;5512.448755124456;5530.5852061095575;5535.418781027934;5582.162675598612;5643.783043665071;5017.921146953423;5256.553192978563;5269.473052694777;5271.446498117719;5303.655262407931;2975.8065725727756;3021.773366997484;3023.576699262105;3033.4377795435366;3066.877324907023;5708.714564271853;5760;5762.683052432157;5771.278590176228;5791.594588378857;5961.2846458425265;6439.452646525004;6496.350364963466;6500;6503;6493.545451818327;6528.640924749089;6543.705533251015;6545.8690826184165;6557.114789503451;6075.878482430415;6258.906116408349;6283.7800676976085;6296.401841825019;6325.620462772248;6206.162168107247;6215.906761398493;6234.376562343729;6236.407541283571;6249.25008998923;6310.684465776784;6466.708998095191;6510.21877374718;6526.967365163144;6548.574342667712;4331;4352.2383582872235;4362.258416069212;4405.140997505456;4411.470623525198;6182.598131121463;6356.300806911144;6387.361263873576;6407.263164736115;6409.7436102555375;6143.232095988002;6145.985912324416;6152.169457123231;6159.96920015415;6212.142414489385;6056.273247210187;6135.294441139147;6150.630962142286;6174.197354343906;6239.220097487814;6011.609245399035;6050;6088.756449741961;6090.320259085988;6121.234845644294;6205.317415084427;6215.782447614311;6217.253929528486;6226.688665566794;6230.7507699691505;5825.3883342248455;5997.0914106657365;6028.8794224116145;6060.545459090497;6080.847978800565 09:58:28 INFO - PROCESS | 18652 | |5;yui.html;806.2421323955482;806.8103995561042;809.3039985612373;898.0929261445938;912.6942474271119;14707.26463676816;15937.840621593781;16066.357345706158;16181.757273640875;16219.189040547955;14246;14474.927625361885;14509.274536273197;14523.709525809478;14528.273586320694;737.5906371963558;843.4138273899642;852.2840813716477;885.9468431894107;892.687559354224;898.8292224477361;899.5727029660924;900.3157600223844;900.9054049324825;902.1249388093539;944.6646440513622;946.7633091727068;949.5442187749884;951.2390087929629;952.3000594563025;939.9812003759921;944.1313991128178;947.9336446448751;950.5057370167474;951.5432592355708;695.4610177112728;697.069412334534;697.2156324135348;698.1622053535777;699.7166147710135;14681.70636587273;14702.11787292755;14722.926385368111;14741.852581474155;14759.77860332096;14601.269936503133;14863.479778207819;15231.086134831945;16607.66784664312;17552.210150543255;14592.562223133324;14639.560813175622;14644;14706.117632942058;14918.850811491855;4791.5687588117235;4826.107170173529;4828.903421931577;4847.12751704693;4880.097182021302;95230;95552.52223738976;96631.51684241604;96642;97281;12200;12272.38638068111;12300.446479908247;12367.876321236852;12399.070069744805;20854.165833366496;20859.37421877346;20911.477213069797;20912.790872091387;20987.58024839495;8952.14954579314;9241.260699144052;9291.907080929239;9419.576119074522;9471.289653275893;4963.925541116886;5025.748712564357;5050.419201791841;5231.8168864089575;5315.441878602768;3675.7610755301353;3762.529683789526;3770.7171962102952;3793.0517370657335;3813.370793819044;648.9740410383627;656.1568384625733;664.0802488553388;677.4648028057779;689.183317768446;602.7498588085983;765.395337683224;796.5423275405993;796.6494742313364;814.3241109878786;9592.856107158399;9768.90231097694;9897.802043959224;10026.849597256047;10062.798744025078;739.593223726948;764.5107131435885;772.3396495995955;806.1293802693077;807.1605530248593;4754.144254034238;4785.114753770494;4854.781534830941;4876.561109500091;4887.633427492952;94301;123419;124075.37962310131;126840.36579817042;131341;112876.43561782138;118099;118619;120214.39892800654;123217.38391308165;98841;102305;102579;103150.48424757828;105637.47181264045;8980.86528702083;9473.52632368365;9677.258293223498;9805.2646051545;9884.604615815575;52983.73508132589;59176.408235917086;59183.40816591779;59729.701351492964;60916.39083609107;52258.73870630623;64035;77307.61346193233;78671;79004.20995789969;13721;13800.792988105388;13916;13929.442822286996;13938.721225575635;14861.92569037148;14938;15042.548723538312;15067.547973560373;15919.442819501262;12952.158109722837;13070.673233169247;13751.381187846371;13788.86211137916;13856.237906915216;12720.363981800689;14184.58808163563;14255.358508866919;14417.639559011108;14554.199519026555;10329.793404131726;12533.686657833627;13249.337533123113;13573.11774734639;14319.069260498034;10883.292585981886;11480.368579728196;11485.942570287096;11502.194846360675;11911.463984120563;11416.657500275005;11445.885541144815;11691.123165762772;11997;12190.329531875832 09:58:28 INFO - PROCESS | 18652 | __end_tp_report 09:58:28 INFO - PROCESS | 18652 | __start_cc_report 09:58:28 INFO - PROCESS | 18652 | _x_x_mozilla_cycle_collect,339 09:58:28 INFO - PROCESS | 18652 | __end_cc_report 09:58:28 INFO - PROCESS | 18652 | __startTimestamp1474304308666__endTimestamp 09:58:28 INFO - PROCESS | 18652 | 09:58:28 INFO - PROCESS | 18652 | ------- Summary: start ------- 09:58:28 INFO - PROCESS | 18652 | Number of tests: 6 09:58:28 INFO - PROCESS | 18652 | 09:58:28 INFO - PROCESS | 18652 | [#0] dojo.html Cycles:165 Average:5820.78 Median:6064.48 stddev:666.51 (11.0%) stddev-sans-first:638.59 09:58:28 INFO - PROCESS | 18652 | Values: 3301.8 3332.3 3336.9 3352.5 3362.9 5735.8 5792.8 5815.8 5820.4 5822.2 5820.2 5883.8 5896.2 5903.4 5922.3 5299.9 5357.7 5380.5 5405.8 5456.2 5279.3 5282.2 5292.6 5323.5 5348.8 5356.3 5371.4 5388.1 5438.6 5440.5 5413.2 5415.8 5419.5 5424.0 5428.1 5156.1 5191.0 5270.6 5349.3 5453.8 5693.9 5772.6 5815.1 5829.2 5832.4 6226.1 6269.1 6286.5 6294.9 6316.8 6079.5 6138.3 6299.5 6327.4 6353.3 5772.3 5871.4 5875.7 5896.5 5911.9 6401.9 6403.2 6415.0 6442.3 6457.8 6033.2 6064.5 6171.9 6184.8 6198.6 6127.3 6211.0 6236.4 6236.8 6237.7 6175.3 6201.1 6206.0 6207.4 6224.8 6069.8 6092.0 6193.1 6195.7 6201.6 4656.3 4771.4 4775.9 4803.2 4806.1 4231.8 4246.7 4246.7 4266.0 4279.8 5872.6 5928.9 5993.8 6057.3 6066.0 6199.2 6307.3 6321.3 6322.6 6332.9 6029.2 6036.9 6062.7 6074.4 6096.2 5263.3 5327.4 5378.6 5422.5 5426.1 6367.9 6518.6 6518.9 6525.2 6531.1 6319.3 6335.9 6349.0 6350.8 6353.0 6280.1 6367.7 6475.9 6475.9 6538.9 6100.8 6211.8 6213.0 6214.0 6214.5 6277.4 6307.7 6322.8 6325.2 6338.2 6030.5 6061.2 6155.2 6165.3 6180.4 6059.8 6122.0 6152.0 6161.4 6169.9 6117.7 6118.3 6124.1 6125.4 6137.1 5998.1 6099.1 6158.2 6177.8 6195.4 5907.6 5985.3 6009.8 6039.2 6047.2 09:58:28 INFO - PROCESS | 18652 | 09:58:28 INFO - PROCESS | 18652 | [#1] ext.html Cycles:180 Average:68950.44 Median:45904.20 stddev:139422.52 (303.7%) stddev-sans-first:139719.13 09:58:28 INFO - PROCESS | 18652 | Values: 577.7 639.6 655.3 656.4 693.0 40963.2 45534.1 45879.5 45884.1 45993.8 46492.8 46646.3 46926.3 47063.5 47070.8 8936.9 9123.1 9141.0 9145.2 9158.1 9114.1 9169.8 9193.0 9195.1 9226.9 9205.4 9205.9 9219.3 9236.5 9249.4 9165.8 9165.9 9170.3 9191.6 9207.2 9026.3 9070.4 9121.6 9148.3 9148.9 44255.8 44748.3 44766.0 44786.0 45001.3 3416.0 3727.5 3730.0 4037.6 4230.7 35277.3 35613.5 35970.8 36558.0 36856.4 4659.8 4702.6 4729.4 4794.9 4814.0 404079.0 406381.0 409263.0 409414.0 409466.0 67659.3 67781.7 67955.0 68126.3 68203.0 39883.8 70912.0 71006.3 71013.6 71162.6 19218.4 19570.2 19598.2 19624.0 19687.4 15119.2 15269.8 15286.2 15295.8 15300.3 20811.4 21063.8 21100.2 21113.0 21159.3 7241.7 7345.8 7404.2 7411.7 7741.3 1028.8 1128.9 1143.5 1158.9 1187.5 33499.2 33663.7 34002.1 34397.0 34492.7 1156.5 1157.5 1189.7 1209.4 1239.7 17907.5 18052.5 18110.0 18138.3 18160.5 625421.0 625699.0 626721.0 631660.0 633432.0 65376.3 65529.3 65642.7 65649.4 65982.3 1449.6 1461.0 1477.6 1481.7 1482.6 33245.2 33699.0 33756.3 33965.5 33982.2 56805.7 56958.4 57059.7 57250.4 57416.7 501825.0 513430.0 517877.0 517995.0 520079.0 31760.0 32083.5 32115.7 32139.8 32322.7 53319.7 53557.5 54335.2 55134.0 55529.2 44756.7 44935.3 46183.8 47043.8 47766.5 45868.5 45924.3 46222.5 46304.5 46706.3 44747.6 45431.8 45552.3 46172.5 48794.0 39449.0 40271.2 40787.0 40827.4 41411.6 29933.4 30221.7 30441.4 30461.8 30775.7 09:58:28 INFO - PROCESS | 18652 | 09:58:28 INFO - PROCESS | 18652 | [#2] jquery.html Cycles:180 Average:30805.07 Median:11534.33 stddev:86889.13 (753.3%) stddev-sans-first:87102.93 09:58:28 INFO - PROCESS | 18652 | Values: 421.4 429.8 431.2 444.1 448.3 19438.0 20601.4 21082.3 21139.0 21193.4 19587.6 20120.3 20139.9 20457.4 20505.2 5818.5 6019.4 6027.6 6028.8 6036.4 5621.9 5829.6 5874.6 5882.8 5990.3 5878.4 5878.8 5911.1 5952.5 6349.4 6388.5 6568.7 6681.1 6699.8 6723.2 5816.2 5973.8 5995.0 6003.5 6018.9 14280.7 14502.4 14542.9 14721.3 14744.6 2473.4 2518.9 2567.6 2607.5 2611.6 10096.5 10937.3 12646.4 14989.6 15793.0 1947.2 1975.9 2033.3 2033.6 2059.9 89139.6 90135.5 91897.0 92989.0 93024.0 10977.8 11280.4 11413.1 11960.8 11997.8 17210.2 17240.0 17257.0 17297.3 17363.5 8181.0 8362.2 8532.6 8589.1 8683.5 7138.5 7208.0 7270.7 7497.8 7543.4 4877.6 4961.5 5034.3 5145.2 5230.7 2016.9 2029.6 2065.2 2077.3 2115.1 939.8 1063.9 1077.4 1104.7 1118.4 20151.1 20401.2 20512.2 20622.7 20991.4 1026.9 1046.4 1060.0 1061.1 1092.6 10711.6 11512.3 11574.9 11579.4 11586.9 513714.0 520985.0 523668.0 526985.0 544863.0 93889.5 95253.5 96380.5 101804.0 103481.5 1086.5 1089.3 1113.2 1118.3 1121.9 18417.4 18739.6 19124.5 19202.0 19551.0 40848.0 41623.9 45542.0 46884.0 47054.3 60694.4 61315.0 61566.7 62463.4 63248.8 8435.2 8638.0 8910.7 8933.6 9020.2 11045.6 12850.7 13283.8 13357.3 13607.0 11640.6 11715.0 12057.3 12097.9 12099.3 11475.1 11575.6 11641.1 11722.8 11966.5 11632.1 11785.0 11859.9 11944.2 12037.0 7916.4 8133.7 8156.6 8556.9 9128.3 11798.0 11875.8 12096.1 12221.4 12400.1 09:58:28 INFO - PROCESS | 18652 | 09:58:28 INFO - PROCESS | 18652 | [#3] mootools.html Cycles:180 Average:6304.50 Median:4944.07 stddev:3567.32 (72.2%) stddev-sans-first:3559.22 09:58:28 INFO - PROCESS | 18652 | Values: 1520.9 1550.6 1685.0 1802.0 1809.7 8561.1 8977.8 9249.5 9629.2 9650.0 9237.8 9576.0 9596.3 9605.9 9606.0 2539.7 2574.5 2585.6 2586.9 2590.5 2452.6 2567.6 2567.9 2569.3 2571.0 2567.5 2578.9 2604.2 2606.9 2609.4 2522.2 2530.0 2534.9 2536.1 2559.9 2461.5 2479.7 2482.8 2483.1 2496.6 9715.8 9798.1 9807.9 9826.6 9828.4 5625.3 5794.5 5870.9 5896.2 5901.1 3465.7 3606.7 3630.2 3638.1 3680.2 1186.9 1258.2 1261.7 1273.6 1282.0 12706.7 13033.9 13055.2 13448.1 13706.4 4938.8 4949.3 4953.1 5023.0 5074.5 10128.9 10139.2 10149.0 10159.6 10161.9 5799.2 5820.3 5828.0 5830.9 5839.8 5195.6 5371.8 5374.3 5435.0 5476.5 4252.4 4309.8 4328.9 4332.9 4347.5 1269.0 1271.9 1282.7 1291.1 1297.4 932.0 964.1 980.2 984.2 1024.3 6101.4 6143.9 6447.6 6468.0 6513.7 994.5 1042.4 1058.9 1062.4 1069.9 4359.4 4486.3 4545.7 4552.0 4578.5 11964.3 12203.4 12216.9 12325.0 12342.3 11275.5 11604.7 11680.2 11997.5 12184.0 8911.7 9092.3 9097.8 9117.7 9158.7 6161.5 6427.2 6779.7 6780.9 6846.0 10677.0 11147.6 11160.9 11222.0 11284.2 11115.7 11153.9 11235.2 11291.4 11406.3 7991.8 8056.7 8202.2 8306.4 8343.9 9558.0 9602.7 9630.6 9649.2 9653.0 8074.7 8359.9 8428.8 8453.2 8475.7 8429.1 8449.7 8488.7 8488.9 8518.8 7340.7 7424.7 7498.0 7502.7 7525.7 5459.5 5484.4 5598.0 5610.1 5737.8 5574.0 5715.5 5778.1 5784.0 5796.9 09:58:28 INFO - PROCESS | 18652 | 09:58:28 INFO - PROCESS | 18652 | [#4] prototype.html Cycles:180 Average:5070.44 Median:5741.46 stddev:1514.15 (26.4%) stddev-sans-first:1476.18 09:58:28 INFO - PROCESS | 18652 | Values: 340.0 343.9 344.0 346.7 347.9 5870.6 5895.6 5917.6 5954.3 5967.6 5756.8 5780.4 5787.4 5791.6 5850.0 4528.5 4540.0 4545.3 4559.7 4594.5 4437.5 4538.6 4539.5 4549.0 4594.0 4474.7 4481.3 4482.8 4484.0 4487.3 4493.2 4506.4 4526.6 4527.4 4573.6 3829.4 3883.7 3938.4 3983.0 3988.4 5641.5 5653.7 5656.7 5657.9 5726.1 5131.2 5138.2 5139.3 5152.0 5186.4 5865.8 6125.8 6135.3 6137.2 6229.4 4329.3 4349.9 4375.7 4401.5 4402.6 6275.7 6418.8 6447.9 6489.6 6515.8 4398.6 4398.7 4401.4 4419.7 4423.7 4456.7 4469.0 4482.3 4504.2 4525.0 5211.6 5220.8 5229.2 5243.4 5258.3 5866.7 6029.8 6052.4 6165.8 6175.3 1524.7 1541.0 1553.7 1558.9 1560.9 967.9 980.9 980.9 985.6 996.6 5256.4 5259.4 5272.6 5278.9 5285.2 5512.4 5530.6 5535.4 5582.2 5643.8 5017.9 5256.6 5269.5 5271.4 5303.7 2975.8 3021.8 3023.6 3033.4 3066.9 5708.7 5760.0 5762.7 5771.3 5791.6 5961.3 6439.5 6496.4 6500.0 6503.0 6493.5 6528.6 6543.7 6545.9 6557.1 6075.9 6258.9 6283.8 6296.4 6325.6 6206.2 6215.9 6234.4 6236.4 6249.3 6310.7 6466.7 6510.2 6527.0 6548.6 4331.0 4352.2 4362.3 4405.1 4411.5 6182.6 6356.3 6387.4 6407.3 6409.7 6143.2 6146.0 6152.2 6160.0 6212.1 6056.3 6135.3 6150.6 6174.2 6239.2 6011.6 6050.0 6088.8 6090.3 6121.2 6205.3 6215.8 6217.3 6226.7 6230.8 5825.4 5997.1 6028.9 6060.5 6080.8 09:58:28 INFO - PROCESS | 18652 | 09:58:28 INFO - PROCESS | 18652 | [#5] yui.html Cycles:180 Average:22830.20 Median:4769.63 stddev:34034.02 (713.6%) stddev-sans-first:34089.32 09:58:28 INFO - PROCESS | 18652 | Values: 806.2 806.8 809.3 898.1 912.7 14707.3 15937.8 16066.4 16181.8 16219.2 14246.0 14474.9 14509.3 14523.7 14528.3 737.6 843.4 852.3 885.9 892.7 898.8 899.6 900.3 900.9 902.1 944.7 946.8 949.5 951.2 952.3 940.0 944.1 947.9 950.5 951.5 695.5 697.1 697.2 698.2 699.7 14681.7 14702.1 14722.9 14741.9 14759.8 14601.3 14863.5 15231.1 16607.7 17552.2 14592.6 14639.6 14644.0 14706.1 14918.9 4791.6 4826.1 4828.9 4847.1 4880.1 95230.0 95552.5 96631.5 96642.0 97281.0 12200.0 12272.4 12300.4 12367.9 12399.1 20854.2 20859.4 20911.5 20912.8 20987.6 8952.1 9241.3 9291.9 9419.6 9471.3 4963.9 5025.7 5050.4 5231.8 5315.4 3675.8 3762.5 3770.7 3793.1 3813.4 649.0 656.2 664.1 677.5 689.2 602.7 765.4 796.5 796.6 814.3 9592.9 9768.9 9897.8 10026.8 10062.8 739.6 764.5 772.3 806.1 807.2 4754.1 4785.1 4854.8 4876.6 4887.6 94301.0 123419.0 124075.4 126840.4 131341.0 112876.4 118099.0 118619.0 120214.4 123217.4 98841.0 102305.0 102579.0 103150.5 105637.5 8980.9 9473.5 9677.3 9805.3 9884.6 52983.7 59176.4 59183.4 59729.7 60916.4 52258.7 64035.0 77307.6 78671.0 79004.2 13721.0 13800.8 13916.0 13929.4 13938.7 14861.9 14938.0 15042.5 15067.5 15919.4 12952.2 13070.7 13751.4 13788.9 13856.2 12720.4 14184.6 14255.4 14417.6 14554.2 10329.8 12533.7 13249.3 13573.1 14319.1 10883.3 11480.4 11485.9 11502.2 11911.5 11416.7 11445.9 11691.1 11997.0 12190.3 09:58:28 INFO - PROCESS | 18652 | -------- Summary: end -------- 09:58:28 INFO - PROCESS | 18652 | 09:58:29 INFO - TEST-INFO | 18652: exit 0 09:58:29 INFO - TEST-OK | dromaeo_css | took 1110513ms 09:58:29 INFO - TEST-START | kraken 09:58:29 INFO - operating with platform_type : linux_ 09:58:29 INFO - Initialising browser for kraken test... 09:58:29 INFO - TEST-INFO | started process 18893 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCt3Z3K/profile http://localhost:56791/getInfo.html) 09:58:33 INFO - PROCESS | 18893 | __metrics Screen width/height:1600/1200 09:58:33 INFO - PROCESS | 18893 | colorDepth:24 09:58:33 INFO - PROCESS | 18893 | Browser inner width/height: 1024/697 09:58:33 INFO - PROCESS | 18893 | __metrics 09:58:34 ERROR - PROCESS | 18893 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 09:58:34 INFO - TEST-INFO | 18893: exit 0 09:58:34 INFO - Browser initialized. 09:58:34 INFO - Running cycle 1/1 for kraken test... 09:58:34 INFO - TEST-INFO | started process 19021 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCt3Z3K/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:58:46 INFO - PROCESS | 19021 | RSS: Main: 149905408 09:58:46 INFO - PROCESS | 19021 | 09:58:49 INFO - PROCESS | 19021 | Cycle 1(1): loaded http://localhost:56791/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56791/tests/kraken/driver.html?testName=audio-beat-detection) 09:58:49 INFO - PROCESS | 19021 | RSS: Main: 156454912 09:58:49 INFO - PROCESS | 19021 | 09:58:52 INFO - PROCESS | 19021 | Cycle 1(1): loaded http://localhost:56791/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56791/tests/kraken/driver.html?testName=audio-dft) 09:58:53 INFO - PROCESS | 19021 | RSS: Main: 155435008 09:58:53 INFO - PROCESS | 19021 | 09:58:55 INFO - PROCESS | 19021 | Cycle 1(1): loaded http://localhost:56791/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56791/tests/kraken/driver.html?testName=audio-fft) 09:58:56 INFO - PROCESS | 19021 | RSS: Main: 156078080 09:58:56 INFO - PROCESS | 19021 | 09:58:58 INFO - PROCESS | 19021 | Cycle 1(1): loaded http://localhost:56791/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56791/tests/kraken/driver.html?testName=audio-oscillator) 09:58:59 INFO - PROCESS | 19021 | RSS: Main: 155521024 09:58:59 INFO - PROCESS | 19021 | 09:59:01 INFO - PROCESS | 19021 | Cycle 1(1): loaded http://localhost:56791/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56791/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:59:02 INFO - PROCESS | 19021 | RSS: Main: 155107328 09:59:02 INFO - PROCESS | 19021 | 09:59:05 INFO - PROCESS | 19021 | Cycle 1(1): loaded http://localhost:56791/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56791/tests/kraken/driver.html?testName=imaging-darkroom) 09:59:05 INFO - PROCESS | 19021 | RSS: Main: 155246592 09:59:05 INFO - PROCESS | 19021 | 09:59:09 INFO - PROCESS | 19021 | Cycle 1(1): loaded http://localhost:56791/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56791/tests/kraken/driver.html?testName=imaging-desaturate) 09:59:09 INFO - PROCESS | 19021 | RSS: Main: 156073984 09:59:09 INFO - PROCESS | 19021 | 09:59:12 INFO - PROCESS | 19021 | Cycle 1(1): loaded http://localhost:56791/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56791/tests/kraken/driver.html?testName=json-parse-financial) 09:59:13 INFO - PROCESS | 19021 | RSS: Main: 156356608 09:59:13 INFO - PROCESS | 19021 | 09:59:14 INFO - PROCESS | 19021 | Cycle 1(1): loaded http://localhost:56791/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56791/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:59:15 INFO - PROCESS | 19021 | RSS: Main: 155426816 09:59:15 INFO - PROCESS | 19021 | 09:59:17 INFO - PROCESS | 19021 | Cycle 1(1): loaded http://localhost:56791/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56791/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:59:17 INFO - PROCESS | 19021 | RSS: Main: 155938816 09:59:17 INFO - PROCESS | 19021 | 09:59:19 INFO - PROCESS | 19021 | Cycle 1(1): loaded http://localhost:56791/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56791/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:59:20 INFO - PROCESS | 19021 | RSS: Main: 156483584 09:59:20 INFO - PROCESS | 19021 | 09:59:22 INFO - PROCESS | 19021 | Cycle 1(1): loaded http://localhost:56791/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56791/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:59:23 INFO - PROCESS | 19021 | RSS: Main: 156729344 09:59:23 INFO - PROCESS | 19021 | 09:59:26 INFO - PROCESS | 19021 | Cycle 1(1): loaded http://localhost:56791/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56791/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:59:26 INFO - PROCESS | 19021 | RSS: Main: 156848128 09:59:26 INFO - PROCESS | 19021 | 09:59:28 INFO - PROCESS | 19021 | Cycle 1(1): loaded http://localhost:56791/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56791/tests/kraken/driver.html?testName=ai-astar) 09:59:28 INFO - PROCESS | 19021 | RSS: Main: 158478336 09:59:28 INFO - PROCESS | 19021 | 09:59:28 INFO - PROCESS | 19021 | __start_tp_report 09:59:28 INFO - PROCESS | 19021 | _x_x_mozilla_page_load 09:59:28 INFO - PROCESS | 19021 | _x_x_mozilla_page_load_details 09:59:28 INFO - PROCESS | 19021 | |i|pagename|runs| 09:59:28 INFO - PROCESS | 19021 | |0;ai-astar;101;113;107;112;113;113;110;114;116;114 09:59:28 INFO - PROCESS | 19021 | |1;audio-beat-detection;150;119;143;169;116;142;143;117;170;116 09:59:28 INFO - PROCESS | 19021 | |2;audio-dft;163;162;162;162;162;166;163;162;164;163 09:59:28 INFO - PROCESS | 19021 | |3;audio-fft;76;75;74;170;76;75;75;75;168;75 09:59:28 INFO - PROCESS | 19021 | |4;audio-oscillator;83;84;150;84;83;83;143;84;85;135 09:59:28 INFO - PROCESS | 19021 | |5;imaging-gaussian-blur;119;117;117;117;117;117;122;118;117;118 09:59:28 INFO - PROCESS | 19021 | |6;imaging-darkroom;147;149;147;147;147;148;147;147;148;148 09:59:28 INFO - PROCESS | 19021 | |7;imaging-desaturate;94;95;97;96;96;95;95;96;95;95 09:59:28 INFO - PROCESS | 19021 | |8;json-parse-financial;54;56;54;55;53;58;55;58;55;54 09:59:28 INFO - PROCESS | 19021 | |9;json-stringify-tinderbox;63;59;58;57;58;61;59;58;58;58 09:59:28 INFO - PROCESS | 19021 | |10;stanford-crypto-aes;72;75;73;78;73;71;73;75;72;72 09:59:28 INFO - PROCESS | 19021 | |11;stanford-crypto-ccm;126;118;120;123;119;125;122;118;162;122 09:59:28 INFO - PROCESS | 19021 | |12;stanford-crypto-pbkdf2;154;153;158;155;150;154;156;154;151;150 09:59:28 INFO - PROCESS | 19021 | |13;stanford-crypto-sha256-iterative;64;61;63;62;62;61;60;61;61;64 09:59:28 INFO - PROCESS | 19021 | __end_tp_report 09:59:28 INFO - PROCESS | 19021 | __start_cc_report 09:59:28 INFO - PROCESS | 19021 | _x_x_mozilla_cycle_collect,888 09:59:28 INFO - PROCESS | 19021 | __end_cc_report 09:59:28 INFO - PROCESS | 19021 | __startTimestamp1474304368718__endTimestamp 09:59:28 INFO - PROCESS | 19021 | 09:59:28 INFO - PROCESS | 19021 | ------- Summary: start ------- 09:59:28 INFO - PROCESS | 19021 | Number of tests: 14 09:59:28 INFO - PROCESS | 19021 | 09:59:28 INFO - PROCESS | 19021 | [#0] ai-astar Cycles:10 Average:111.30 Median:113.00 stddev:4.37 (3.9%) stddev-sans-first:2.60 09:59:28 INFO - PROCESS | 19021 | Values: 101.0 113.0 107.0 112.0 113.0 113.0 110.0 114.0 116.0 114.0 09:59:28 INFO - PROCESS | 19021 | 09:59:28 INFO - PROCESS | 19021 | [#1] audio-beat-detection Cycles:10 Average:138.50 Median:143.00 stddev:20.98 (14.7%) stddev-sans-first:21.84 09:59:28 INFO - PROCESS | 19021 | Values: 150.0 119.0 143.0 169.0 116.0 142.0 143.0 117.0 170.0 116.0 09:59:28 INFO - PROCESS | 19021 | 09:59:28 INFO - PROCESS | 19021 | [#2] audio-dft Cycles:10 Average:162.90 Median:163.00 stddev:1.29 (0.8%) stddev-sans-first:1.36 09:59:28 INFO - PROCESS | 19021 | Values: 163.0 162.0 162.0 162.0 162.0 166.0 163.0 162.0 164.0 163.0 09:59:28 INFO - PROCESS | 19021 | 09:59:28 INFO - PROCESS | 19021 | [#3] audio-fft Cycles:10 Average:93.90 Median:75.00 stddev:39.59 (52.8%) stddev-sans-first:41.46 09:59:28 INFO - PROCESS | 19021 | Values: 76.0 75.0 74.0 170.0 76.0 75.0 75.0 75.0 168.0 75.0 09:59:28 INFO - PROCESS | 19021 | 09:59:28 INFO - PROCESS | 19021 | [#4] audio-oscillator Cycles:10 Average:101.40 Median:83.50 stddev:28.70 (34.4%) stddev-sans-first:29.66 09:59:28 INFO - PROCESS | 19021 | Values: 83.0 84.0 150.0 84.0 83.0 83.0 143.0 84.0 85.0 135.0 09:59:28 INFO - PROCESS | 19021 | 09:59:28 INFO - PROCESS | 19021 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:117.50 stddev:1.60 (1.4%) stddev-sans-first:1.64 09:59:28 INFO - PROCESS | 19021 | Values: 119.0 117.0 117.0 117.0 117.0 117.0 122.0 118.0 117.0 118.0 09:59:28 INFO - PROCESS | 19021 | 09:59:28 INFO - PROCESS | 19021 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:147.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 09:59:28 INFO - PROCESS | 19021 | Values: 147.0 149.0 147.0 147.0 147.0 148.0 147.0 147.0 148.0 148.0 09:59:28 INFO - PROCESS | 19021 | 09:59:28 INFO - PROCESS | 19021 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.84 (0.9%) stddev-sans-first:0.73 09:59:28 INFO - PROCESS | 19021 | Values: 94.0 95.0 97.0 96.0 96.0 95.0 95.0 96.0 95.0 95.0 09:59:28 INFO - PROCESS | 19021 | 09:59:28 INFO - PROCESS | 19021 | [#8] json-parse-financial Cycles:10 Average:55.20 Median:55.00 stddev:1.69 (3.1%) stddev-sans-first:1.73 09:59:28 INFO - PROCESS | 19021 | Values: 54.0 56.0 54.0 55.0 53.0 58.0 55.0 58.0 55.0 54.0 09:59:28 INFO - PROCESS | 19021 | 09:59:28 INFO - PROCESS | 19021 | [#9] json-stringify-tinderbox Cycles:10 Average:58.90 Median:58.50 stddev:1.79 (3.1%) stddev-sans-first:1.13 09:59:28 INFO - PROCESS | 19021 | Values: 63.0 59.0 58.0 57.0 58.0 61.0 59.0 58.0 58.0 58.0 09:59:28 INFO - PROCESS | 19021 | 09:59:28 INFO - PROCESS | 19021 | [#10] stanford-crypto-aes Cycles:10 Average:73.40 Median:73.00 stddev:2.07 (2.8%) stddev-sans-first:2.13 09:59:28 INFO - PROCESS | 19021 | Values: 72.0 75.0 73.0 78.0 73.0 71.0 73.0 75.0 72.0 72.0 09:59:28 INFO - PROCESS | 19021 | 09:59:28 INFO - PROCESS | 19021 | [#11] stanford-crypto-ccm Cycles:10 Average:125.50 Median:122.50 stddev:13.12 (10.7%) stddev-sans-first:13.91 09:59:28 INFO - PROCESS | 19021 | Values: 126.0 118.0 120.0 123.0 119.0 125.0 122.0 118.0 162.0 122.0 09:59:28 INFO - PROCESS | 19021 | 09:59:28 INFO - PROCESS | 19021 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.50 Median:154.00 stddev:2.59 (1.7%) stddev-sans-first:2.74 09:59:28 INFO - PROCESS | 19021 | Values: 154.0 153.0 158.0 155.0 150.0 154.0 156.0 154.0 151.0 150.0 09:59:28 INFO - PROCESS | 19021 | 09:59:28 INFO - PROCESS | 19021 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.90 Median:62.00 stddev:1.37 (2.2%) stddev-sans-first:1.22 09:59:28 INFO - PROCESS | 19021 | Values: 64.0 61.0 63.0 62.0 62.0 61.0 60.0 61.0 61.0 64.0 09:59:28 INFO - PROCESS | 19021 | -------- Summary: end -------- 09:59:28 INFO - PROCESS | 19021 | 09:59:29 INFO - TEST-INFO | 19021: exit 0 09:59:29 INFO - TEST-OK | kraken | took 60354ms 09:59:29 INFO - SUITE-END | took 1170s 09:59:29 INFO - Completed test suite (00:19:31) 09:59:29 INFO - javascript benchmark 09:59:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7821.172224390876, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3301.8349082545874, 3332.3168750406153, 3336.932181701856, 3352.4971254311868, 3362.882299119531, 5735.7705691772335, 5792.826215213539, 5815.796447124351, 5820.38885916979, 5822.155787410823, 5820.214271073404, 5883.823485295437, 5896.174535565025, 5903.4391732785425, 5922.2597175353085, 5299.920501192485, 5357.651752636086, 5380.515753582196, 5405.783768649249, 5456.208849716809, 5279.287296215, 5282.154855223165, 5292.550133238679, 5323.494268044549, 5348.839534813962, 5356.276902618155, 5371.355437347524, 5388.084025715618, 5438.592105592076, 5440.483154100354, 5413.188021796742, 5415.756290966916, 5419.5393391561565, 5424.0236757383655, 5428.0500912340185, 5156.149235376159, 5191.039657663345, 5270.578353731692, 5349.3045904032615, 5453.809116680937, 5693.857653558653, 5772.624779389326, 5815.127730840365, 5829.183914252008, 5832.358440571534, 6226.066090086478, 6269.122322874801, 6286.528510361695, 6294.87410251797, 6316.778912738078, 6079.513638908877, 6138.2964379703635, 6299.496040316763, 6327.430531252209, 6353.30113687494, 5772.30732312121, 5871.383504731984, 5875.676837773878, 5896.469317761379, 5911.9113213301835, 6401.9039714404325, 6403.167588213596, 6415.0, 6442.259140198843, 6457.838554036092, 6033.155358249848, 6064.48451881595, 6171.876562468726, 6184.81445556634, 6198.597091189058, 6127.295361033449, 6210.968945155245, 6236.376362363818, 6236.781712640036, 6237.688115594202, 6175.2589689237575, 6201.131841542187, 6206.0, 6207.441330280297, 6224.782132625336, 6069.787557435468, 6091.9695401523595, 6193.071039344044, 6195.690215489208, 6201.565890387629, 4656.32483289921, 4771.355866957986, 4775.928361074587, 4803.159447096744, 4806.086843499724, 4231.7672528010635, 4246.660267178619, 4246.723962942398, 4266.0, 4279.828806847691, 5872.559558033079, 5928.9407105928385, 5993.820185394445, 6057.3336932937345, 6065.969670151621, 6199.194104766441, 6307.274663413675, 6321.336259692758, 6322.620642761357, 6332.873342533124, 6029.216201893726, 6036.879262414815, 6062.696865156725, 6074.362191969868, 6096.177016102858, 5263.315768950089, 5327.413984461706, 5378.596605254622, 5422.53908417781, 5426.077566813651, 6367.904481432783, 6518.608883467007, 6518.934810651927, 6525.1517302750335, 6531.0856480092825, 6319.273283572448, 6335.90496142549, 6348.999999999907, 6350.7777227796805, 6352.968235158794, 6280.057991301342, 6367.713452894724, 6475.902861457176, 6475.935240647534, 6538.934610653832, 6100.816975490742, 6211.81364559064, 6213.0, 6214.036824292242, 6214.5028397727165, 6277.435030847246, 6307.716152773044, 6322.841928951813, 6325.209348831396, 6338.207724034496, 6030.517558595389, 6061.181740464981, 6155.230596175478, 6165.32181460048, 6180.381961803783, 6059.848503787441, 6122.0, 6151.96924015377, 6161.353057929032, 6169.907451388322, 6117.694115294128, 6118.284172697687, 6124.050772130327, 6125.378848301115, 6137.120988813815, 5998.070299103646, 6099.054646529795, 6158.230221222348, 6177.84555386119, 6195.411435913581, 5907.645541267538, 5985.25184351956, 6009.789657361971, 6039.245094363205, 6047.244094488189], "value": 5774.884228621158, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [577.6591810831611, 639.6481934935784, 655.2955572759284, 656.4059526128852, 692.9896051559231, 40963.18073638529, 45534.08931821366, 45879.54120458794, 45884.08231835361, 45993.7700311498, 46492.767536162275, 46646.300305495446, 46926.29610555836, 47063.52936470643, 47070.76464617681, 8936.91063089369, 9123.087691230858, 9140.954295228514, 9145.176934075931, 9158.129977652112, 9114.088591140866, 9169.816603667923, 9193.0, 9195.12646298604, 9226.907730922672, 9205.447673139599, 9205.861912071325, 9219.308551858603, 9236.491992940419, 9249.35254532183, 9165.816683666322, 9165.908340916605, 9170.312226582999, 9191.586378612978, 9207.217386522154, 9026.277897768228, 9070.365074444791, 9121.589528471235, 9148.2681385489, 9148.8627670585, 44255.77872110651, 44748.3287750684, 44766.0, 44786.0, 45001.324980125326, 3415.9658403416147, 3727.5340582427198, 3730.0301921500604, 4037.6366127048414, 4230.661547076226, 35277.29445411077, 35613.46579801305, 35970.820145899364, 36558.0, 36856.44715329272, 4659.790309436084, 4702.647301452371, 4729.432468103815, 4794.9280760788615, 4813.951860481386, 404079.0, 406380.9680951606, 409263.0, 409414.0, 409466.0, 67659.32340676629, 67781.66109169522, 67955.0, 68126.31873681299, 68203.0, 39883.80058099749, 70912.0, 71006.289937101, 71013.64493177501, 71162.64418677977, 19218.4234472966, 19570.21719131219, 19598.21607135727, 19624.0, 19687.40937771869, 15119.244037798066, 15269.847301527065, 15286.159261240517, 15295.770563441558, 15300.311485983157, 20811.375658730263, 21063.78936210649, 21100.155993760076, 21113.049912753962, 21159.25942592002, 7241.674124664402, 7345.816354591178, 7404.1855395906405, 7411.6664750086375, 7741.264579864904, 1028.7993841200894, 1128.8927551882557, 1143.5128595305177, 1158.9478473468714, 1187.5487314820314, 33499.16252093668, 33663.66336336654, 34002.14994625154, 34397.0, 34492.655073449445, 1156.4853640130061, 1157.4685107803025, 1189.690680423079, 1209.4013463335705, 1239.6838806104565, 17907.462776116736, 18052.458426247234, 18110.0, 18138.274469021355, 18160.455186344432, 625421.0, 625699.0, 626721.0, 631660.0, 633432.0, 65376.34623653703, 65529.344706553275, 65642.67178664076, 65649.35876603123, 65982.34017659858, 1449.6303442622275, 1460.9634759131106, 1477.6379786952266, 1481.7406953783045, 1482.6219314075058, 33245.16887077746, 33699.0, 33756.3248735019, 33965.49051764275, 33982.209360720655, 56805.71597141988, 56958.430415695315, 57059.71470142789, 57250.42749572617, 57416.71291643682, 501825.0, 513430.0, 517877.0, 517995.0, 520079.0, 31760.0, 32083.518747218342, 32115.67884321127, 32139.839300803345, 32322.676773231968, 53319.73340133274, 53557.464425356804, 54335.184972224655, 55134.0, 55529.16706249329, 44756.71703303452, 44935.29385403653, 46183.76908115438, 47043.76478117587, 47766.52233477621, 45868.54131458776, 45924.311135332326, 46222.53777462317, 46304.53695463002, 46706.29940550827, 44747.55252447434, 45431.772841135586, 45552.316715248635, 46172.538274618164, 48794.0, 39449.0, 40271.1945761089, 40787.0, 40827.38758918559, 41411.585884140775, 29933.401331973673, 30221.69778302189, 30441.39117217599, 30461.847690761406, 30775.692243077283], "value": 22034.729152031712, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [421.4451490109634, 429.8474041715193, 431.2410158121705, 444.1450208348929, 448.33422367783857, 19438.0, 20601.38195854123, 21082.262120825773, 21139.04874280657, 21193.364199074014, 19587.608247835036, 20120.295789647364, 20139.899300503515, 20457.386278411635, 20505.179792808307, 5818.505427038696, 6019.367966363535, 6027.588964414225, 6028.788992385267, 6036.3661815509395, 5621.943780562183, 5829.621074630157, 5874.647521148745, 5882.823515294526, 5990.341062483145, 5878.441548052928, 5878.764849406019, 5911.083782013795, 5952.464278214959, 6349.365063493637, 6388.520860935425, 6568.737250509974, 6681.1314529110905, 6699.799006029827, 6723.193216813965, 5816.243888294537, 5973.8207853764025, 5995.010823214165, 6003.489703375219, 6018.879622407571, 14280.714385712228, 14502.41990320386, 14542.927285363505, 14721.263936803223, 14744.631384215374, 2473.4063824682125, 2518.874056297196, 2567.56351420259, 2607.478504299148, 2611.6213149093273, 10096.4694181999, 10937.289076210021, 12646.367681615882, 14989.550313490612, 15793.0, 1947.191915355126, 1975.9209631614717, 2033.2680235115347, 2033.6339458897392, 2059.9176032958662, 89139.55430222872, 90135.54932225363, 91897.0, 92989.0, 93024.0, 10977.83533247002, 11280.379579123228, 11413.144014198968, 11960.760784784256, 11997.820032699516, 17210.225539850737, 17240.0, 17257.0, 17297.308107675803, 17363.47909562715, 8181.0, 8362.247397734232, 8532.616032278562, 8589.098144694717, 8683.52240626759, 7138.500304978706, 7208.0, 7270.672819723125, 7497.812554686177, 7543.358814500719, 4877.561019508261, 4961.479044700254, 5034.270030845507, 5145.202493613496, 5230.712310822865, 2016.8890711010743, 2029.604227175716, 2065.215218217098, 2077.2833372486466, 2115.111653105699, 939.8073394954018, 1063.9468026598795, 1077.4074259157433, 1104.7151023966894, 1118.4016551145098, 20151.08574165761, 20401.183952641728, 20512.179512819617, 20622.690659640117, 20991.370258892257, 1026.8870424253325, 1046.398320965448, 1059.9788004240027, 1061.0821639281965, 1092.6175838456636, 10711.625093121704, 11512.251703639236, 11574.88425115755, 11579.363135027654, 11586.942065289788, 513714.0, 520985.0, 523668.0, 526985.0, 544863.0, 93889.53055234817, 95253.5237323809, 96380.51809741047, 101804.0, 103481.48259258656, 1086.5165001574383, 1089.2538611051455, 1113.1818113686595, 1118.2563595209258, 1121.9046381057537, 18417.447476575726, 18739.625207496047, 19124.521886952938, 19202.0, 19551.0, 40848.0, 41623.87355885458, 45542.0, 46884.0, 47054.294185587925, 60694.393056068875, 61315.0, 61566.69216653888, 62463.37536624575, 63248.78629248138, 8435.156484351515, 8637.956810215908, 8910.688125915822, 8933.642654294015, 9020.188183063556, 11045.613403530839, 12850.742985140432, 13283.800742989057, 13357.332133393096, 13607.0, 11640.592579259684, 11715.0, 12057.276563405872, 12097.939510302744, 12099.274043557414, 11475.081993440337, 11575.594854180063, 11641.126915481542, 11722.76554468923, 11966.521339146684, 11632.127590430582, 11785.0, 11859.881401185878, 11944.16390852632, 12037.0, 7916.406269529693, 8133.674653013813, 8156.632951517077, 8556.930383702038, 9128.269738420777, 11798.0, 11875.76248475043, 12096.092793040381, 12221.388930553614, 12400.069994750249], "value": 9623.968210752186, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1520.9011414258075, 1550.565841564362, 1684.9915750421246, 1801.9639607207848, 1809.6742586334462, 8561.143885611436, 8977.820443591125, 9249.53752312385, 9629.181519570837, 9650.034996500346, 9237.76905577361, 9576.0, 9596.28027897907, 9605.903940960588, 9606.0, 2539.746025397459, 2574.5365834149848, 2585.58630619101, 2586.9094581689646, 2590.4689538644625, 2452.583060879646, 2567.550678631241, 2567.884445199961, 2569.267758688774, 2570.9973110486926, 2567.512172687193, 2578.9097381591646, 2604.1536500637276, 2606.9217923462325, 2609.3737502999334, 2522.2433270019014, 2530.0, 2534.9112781052577, 2536.074332868508, 2559.897604095834, 2461.4707837814954, 2479.7148327942336, 2482.8386154900054, 2483.0936708101594, 2496.5506208882393, 9715.757106072335, 9798.069183427562, 9807.90192098077, 9826.606935722562, 9828.361156524803, 5625.268715067056, 5794.50746686528, 5870.853228669274, 5896.233489646319, 5901.114832775118, 3465.6707612776745, 3606.7294952878638, 3630.2195028068827, 3638.072291565634, 3680.2087551176623, 1186.9465874035689, 1258.245052968221, 1261.6719652890222, 1273.5606215855514, 1281.9807702884464, 12706.74586508274, 13033.869661303455, 13055.151415157985, 13448.125871818398, 13706.38321275545, 4938.8271410501175, 4949.307097006422, 4953.083679519301, 5023.045621331935, 5074.467180945948, 10128.949355253177, 10139.239557033252, 10149.035841595036, 10159.644412445678, 10161.898381016243, 5799.18811366409, 5820.30156381237, 5828.038373668382, 5830.883382332329, 5839.795607153814, 5195.584353251731, 5371.838844834661, 5374.27447294618, 5434.972825135849, 5476.534494567926, 4252.4046633471335, 4309.806058727365, 4328.870133895988, 4332.891677708082, 4347.500037495665, 1268.9555865544846, 1271.8728127187208, 1282.7113899372566, 1291.1284882704138, 1297.4096785962365, 932.0, 964.1322809471392, 980.1766516126488, 984.2372161574693, 1024.2522958240527, 6101.420365065312, 6143.938560614337, 6447.6131432114225, 6468.029795530708, 6513.674316284261, 994.5226291380178, 1042.4475028235047, 1058.9311694739818, 1062.442217835627, 1069.909057730086, 4359.38968544404, 4486.304622783474, 4545.681802273809, 4551.977240113778, 4578.519255478127, 11964.341961192044, 12203.389830508439, 12216.938915305544, 12325.0, 12342.321172335429, 11275.492602832892, 11604.6518604442, 11680.182387232982, 11997.460114294878, 12184.0, 8911.688090916787, 9092.272618190662, 9097.81728375307, 9117.680881169259, 9158.67944621935, 6161.537884658579, 6427.164468619049, 6779.72881084751, 6780.898286525608, 6846.0, 10677.0, 11147.609833655782, 11160.888391115985, 11222.0, 11284.153688473232, 11115.722106947067, 11153.888461115284, 11235.15736319763, 11291.43542822872, 11406.315621062762, 7991.760247192594, 8056.677732890619, 8202.179782021989, 8306.377021723516, 8343.874841877498, 9557.99641037681, 9602.711918642452, 9630.614775408905, 9649.228061755182, 9652.951735241279, 8074.677012919417, 8359.874601881098, 8428.831423371621, 8453.154684531497, 8475.660973560989, 8429.114942930904, 8449.66201351939, 8488.74533763988, 8488.915110849059, 8518.829623407373, 7340.669669864762, 7424.665890035069, 7497.962510187414, 7502.662380192795, 7525.661345239587, 5459.481349271813, 5484.396716361117, 5597.972010139923, 5610.102383618601, 5737.827865164052, 5574.024545704405, 5715.542756579547, 5778.133280007864, 5784.0, 5796.94203057964], "value": 5040.351878951798, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [339.960904495983, 343.9363717712225, 344.0401280427607, 346.66546782355033, 347.9286746217025, 5870.559708021894, 5895.555588880725, 5917.585768996167, 5954.31525374581, 5967.641941483508, 5756.769729210827, 5780.4219578042175, 5787.353967000794, 5791.623544469607, 5849.952516619182, 4528.524504926968, 4539.954600453994, 4545.272756358983, 4559.74921379324, 4594.540545945412, 4437.511873693891, 4538.636909047268, 4539.477960034589, 4548.999220171557, 4594.0, 4474.7023363224625, 4481.327800829886, 4482.820687172509, 4483.968687201946, 4487.259602165639, 4493.236149854532, 4506.414166158394, 4526.615237704799, 4527.366168736379, 4573.611243044345, 3829.4064420014943, 3883.6601372526716, 3938.4289278054807, 3982.960170398288, 3988.4216788565786, 5641.492265696107, 5653.745581448845, 5656.745446454919, 5657.896710141524, 5726.141078838166, 5131.179011358165, 5138.177891537373, 5139.3040296702375, 5151.974240128776, 5186.429492755794, 5865.824025279248, 6125.816225513242, 6135.32511423743, 6137.171481849938, 6229.37706229378, 4329.328954012133, 4349.9130017399475, 4375.7374557526655, 4401.515833258339, 4402.647788176938, 6275.7175927083845, 6418.839529011765, 6447.903281450782, 6489.610623362613, 6515.837104072389, 4398.582134697199, 4398.714083584557, 4401.383806267125, 4419.668524860648, 4423.712458690175, 4456.68803183774, 4469.039156581351, 4482.260427029569, 4504.166729155117, 4524.959259370363, 5211.635185536976, 5220.843374698765, 5229.215617657305, 5243.4232234454175, 5258.290130832365, 5866.70666466675, 6029.8191054268445, 6052.364501727343, 6165.8458538536, 6175.258968923668, 1524.7179271834525, 1540.9691806163814, 1553.6814952934621, 1558.883083768722, 1560.9141497217536, 967.9274054445804, 980.9166220871164, 980.9411435313904, 985.5811280205884, 996.5864166371019, 5256.448072952361, 5259.447757985433, 5272.604554658339, 5278.8944221116135, 5285.207218917117, 5512.448755124456, 5530.5852061095575, 5535.418781027934, 5582.162675598612, 5643.783043665071, 5017.921146953423, 5256.553192978563, 5269.473052694777, 5271.446498117719, 5303.655262407931, 2975.8065725727756, 3021.773366997484, 3023.576699262105, 3033.4377795435366, 3066.877324907023, 5708.714564271853, 5760.0, 5762.683052432157, 5771.278590176228, 5791.594588378857, 5961.2846458425265, 6439.452646525004, 6496.350364963466, 6500.0, 6503.0, 6493.545451818327, 6528.640924749089, 6543.705533251015, 6545.8690826184165, 6557.114789503451, 6075.878482430415, 6258.906116408349, 6283.7800676976085, 6296.401841825019, 6325.620462772248, 6206.162168107247, 6215.906761398493, 6234.376562343729, 6236.407541283571, 6249.25008998923, 6310.684465776784, 6466.708998095191, 6510.21877374718, 6526.967365163144, 6548.574342667712, 4331.0, 4352.2383582872235, 4362.258416069212, 4405.140997505456, 4411.470623525198, 6182.598131121463, 6356.300806911144, 6387.361263873576, 6407.263164736115, 6409.7436102555375, 6143.232095988002, 6145.985912324416, 6152.169457123231, 6159.96920015415, 6212.142414489385, 6056.273247210187, 6135.294441139147, 6150.630962142286, 6174.197354343906, 6239.220097487814, 6011.609245399035, 6050.0, 6088.756449741961, 6090.320259085988, 6121.234845644294, 6205.317415084427, 6215.782447614311, 6217.253929528486, 6226.688665566794, 6230.7507699691505, 5825.3883342248455, 5997.0914106657365, 6028.8794224116145, 6060.545459090497, 6080.847978800565], "value": 4580.337972634084, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [806.2421323955482, 806.8103995561042, 809.3039985612373, 898.0929261445938, 912.6942474271119, 14707.26463676816, 15937.840621593781, 16066.357345706158, 16181.757273640875, 16219.189040547955, 14246.0, 14474.927625361885, 14509.274536273197, 14523.709525809478, 14528.273586320694, 737.5906371963558, 843.4138273899642, 852.2840813716477, 885.9468431894107, 892.687559354224, 898.8292224477361, 899.5727029660924, 900.3157600223844, 900.9054049324825, 902.1249388093539, 944.6646440513622, 946.7633091727068, 949.5442187749884, 951.2390087929629, 952.3000594563025, 939.9812003759921, 944.1313991128178, 947.9336446448751, 950.5057370167474, 951.5432592355708, 695.4610177112728, 697.069412334534, 697.2156324135348, 698.1622053535777, 699.7166147710135, 14681.70636587273, 14702.11787292755, 14722.926385368111, 14741.852581474155, 14759.77860332096, 14601.269936503133, 14863.479778207819, 15231.086134831945, 16607.66784664312, 17552.210150543255, 14592.562223133324, 14639.560813175622, 14644.0, 14706.117632942058, 14918.850811491855, 4791.5687588117235, 4826.107170173529, 4828.903421931577, 4847.12751704693, 4880.097182021302, 95230.0, 95552.52223738976, 96631.51684241604, 96642.0, 97281.0, 12200.0, 12272.38638068111, 12300.446479908247, 12367.876321236852, 12399.070069744805, 20854.165833366496, 20859.37421877346, 20911.477213069797, 20912.790872091387, 20987.58024839495, 8952.14954579314, 9241.260699144052, 9291.907080929239, 9419.576119074522, 9471.289653275893, 4963.925541116886, 5025.748712564357, 5050.419201791841, 5231.8168864089575, 5315.441878602768, 3675.7610755301353, 3762.529683789526, 3770.7171962102952, 3793.0517370657335, 3813.370793819044, 648.9740410383627, 656.1568384625733, 664.0802488553388, 677.4648028057779, 689.183317768446, 602.7498588085983, 765.395337683224, 796.5423275405993, 796.6494742313364, 814.3241109878786, 9592.856107158399, 9768.90231097694, 9897.802043959224, 10026.849597256047, 10062.798744025078, 739.593223726948, 764.5107131435885, 772.3396495995955, 806.1293802693077, 807.1605530248593, 4754.144254034238, 4785.114753770494, 4854.781534830941, 4876.561109500091, 4887.633427492952, 94301.0, 123419.0, 124075.37962310131, 126840.36579817042, 131341.0, 112876.43561782138, 118099.0, 118619.0, 120214.39892800654, 123217.38391308165, 98841.0, 102305.0, 102579.0, 103150.48424757828, 105637.47181264045, 8980.86528702083, 9473.52632368365, 9677.258293223498, 9805.2646051545, 9884.604615815575, 52983.73508132589, 59176.408235917086, 59183.40816591779, 59729.701351492964, 60916.39083609107, 52258.73870630623, 64035.0, 77307.61346193233, 78671.0, 79004.20995789969, 13721.0, 13800.792988105388, 13916.0, 13929.442822286996, 13938.721225575635, 14861.92569037148, 14938.0, 15042.548723538312, 15067.547973560373, 15919.442819501262, 12952.158109722837, 13070.673233169247, 13751.381187846371, 13788.86211137916, 13856.237906915216, 12720.363981800689, 14184.58808163563, 14255.358508866919, 14417.639559011108, 14554.199519026555, 10329.793404131726, 12533.686657833627, 13249.337533123113, 13573.11774734639, 14319.069260498034, 10883.292585981886, 11480.368579728196, 11485.942570287096, 11502.194846360675, 11911.463984120563, 11416.657500275005, 11445.885541144815, 11691.123165762772, 11997.0, 12190.329531875832], "value": 8095.171335537667, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1497.2000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 113.0, 107.0, 112.0, 113.0, 113.0, 110.0, 114.0, 116.0, 114.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 119.0, 143.0, 169.0, 116.0, 142.0, 143.0, 117.0, 170.0, 116.0], "value": 138.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 162.0, 162.0, 162.0, 166.0, 163.0, 162.0, 164.0, 163.0], "value": 162.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 74.0, 170.0, 76.0, 75.0, 75.0, 75.0, 168.0, 75.0], "value": 93.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 150.0, 84.0, 83.0, 83.0, 143.0, 84.0, 85.0, 135.0], "value": 101.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 117.0, 117.0, 117.0, 117.0, 117.0, 122.0, 118.0, 117.0, 118.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 149.0, 147.0, 147.0, 147.0, 148.0, 147.0, 147.0, 148.0, 148.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 97.0, 96.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 56.0, 54.0, 55.0, 53.0, 58.0, 55.0, 58.0, 55.0, 54.0], "value": 55.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 59.0, 58.0, 57.0, 58.0, 61.0, 59.0, 58.0, 58.0, 58.0], "value": 58.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 75.0, 73.0, 78.0, 73.0, 71.0, 73.0, 75.0, 72.0, 72.0], "value": 73.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 118.0, 120.0, 123.0, 119.0, 125.0, 122.0, 118.0, 162.0, 122.0], "value": 125.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 153.0, 158.0, 155.0, 150.0, 154.0, 156.0, 154.0, 151.0, 150.0], "value": 153.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 61.0, 63.0, 62.0, 62.0, 61.0, 60.0, 61.0, 61.0, 64.0], "value": 61.9, "unit": "score"}]}]} 09:59:29 INFO - Return code: 0 09:59:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:59:30 ERROR - # TBPL SUCCESS # 09:59:30 INFO - Running post-action listener: _resource_record_post_action 09:59:30 INFO - [mozharness: 2016-09-19 16:59:30.034842Z] Finished run-tests step (success) 09:59:30 INFO - Running post-run listener: _resource_record_post_run 09:59:30 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 4096; Write bytes: 291127296; Read time: 16; Write time: 198576 09:59:30 INFO - TinderboxPrint: CPU usage
13.2% 09:59:30 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 09:59:30 INFO - TinderboxPrint: I/O write bytes / time
291,127,296 / 198,576 09:59:30 INFO - TinderboxPrint: CPU idle
8,208.9 (86.8%) 09:59:30 INFO - TinderboxPrint: CPU user
1,193.9 (12.6%) 09:59:30 INFO - TinderboxPrint: Swap in / out
0 / 0 09:59:30 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 71270400; Read time: 0; Write time: 39668 09:59:30 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 0; Write bytes: 219856896; Read time: 0; Write time: 158908 09:59:30 INFO - Running post-run listener: _upload_blobber_files 09:59:30 INFO - Blob upload gear active. 09:59:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:59:30 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 09:59:30 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'] 09:59:30 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 09:59:31 INFO - (blobuploader) - INFO - Open directory for files ... 09:59:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:59:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:59:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:59:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:59:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:59:32 INFO - (blobuploader) - INFO - Done attempting. 09:59:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:59:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:59:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:59:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:59:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:59:36 INFO - (blobuploader) - INFO - Done attempting. 09:59:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:59:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:59:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:59:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:59:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:59:37 INFO - (blobuploader) - INFO - Done attempting. 09:59:37 INFO - (blobuploader) - INFO - Iteration through files over. 09:59:37 INFO - Return code: 0 09:59:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:59:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:59:37 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1a2574caa48a6fdf173b8f299f97f96b4639f5a499eb8d08a63ed0ba03892d1d46cb55019c3f41ef45ff8580eb43140d80610534c10657e17c0cace6c6f3941e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e2a036e3d82c7ee780288d80918ed16e3e711b9b6bb71ed7eb2fa1d64e141a7b9f02be85407f3d151f19d3abe0c39009d389fe7a3c095541fd604b13f0ce63e6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b8e4f6e4e3237b24aa13394ae288fea5e1e8af31ad0aadcf06eba787db6ca62f5ca3266f6164fd5a849baa038085aaca5d0fc504f16b279060b5bff91880cc47"} 09:59:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:59:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:59:37 INFO - Contents: 09:59:37 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1a2574caa48a6fdf173b8f299f97f96b4639f5a499eb8d08a63ed0ba03892d1d46cb55019c3f41ef45ff8580eb43140d80610534c10657e17c0cace6c6f3941e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e2a036e3d82c7ee780288d80918ed16e3e711b9b6bb71ed7eb2fa1d64e141a7b9f02be85407f3d151f19d3abe0c39009d389fe7a3c095541fd604b13f0ce63e6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b8e4f6e4e3237b24aa13394ae288fea5e1e8af31ad0aadcf06eba787db6ca62f5ca3266f6164fd5a849baa038085aaca5d0fc504f16b279060b5bff91880cc47"} 09:59:37 INFO - Running post-run listener: copy_logs_to_upload_dir 09:59:37 INFO - Copying logs to upload dir... 09:59:37 INFO - mkdir: /builds/slave/test/build/upload/logs 09:59:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1674.324292 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 54 secs) (at 2016-09-19 09:59:37.446671) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-19 09:59:37.450103) ========= 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=6dbc10da6d83fee962c624be000001a8-1474302692.58684-1942397390 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/1a2574caa48a6fdf173b8f299f97f96b4639f5a499eb8d08a63ed0ba03892d1d46cb55019c3f41ef45ff8580eb43140d80610534c10657e17c0cace6c6f3941e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e2a036e3d82c7ee780288d80918ed16e3e711b9b6bb71ed7eb2fa1d64e141a7b9f02be85407f3d151f19d3abe0c39009d389fe7a3c095541fd604b13f0ce63e6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b8e4f6e4e3237b24aa13394ae288fea5e1e8af31ad0aadcf06eba787db6ca62f5ca3266f6164fd5a849baa038085aaca5d0fc504f16b279060b5bff91880cc47"} build_url:https://queue.taskcluster.net/v1/task/NP4rm_HuS0OWUwXOhIFq3A/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011467 build_url: 'https://queue.taskcluster.net/v1/task/NP4rm_HuS0OWUwXOhIFq3A/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/1a2574caa48a6fdf173b8f299f97f96b4639f5a499eb8d08a63ed0ba03892d1d46cb55019c3f41ef45ff8580eb43140d80610534c10657e17c0cace6c6f3941e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e2a036e3d82c7ee780288d80918ed16e3e711b9b6bb71ed7eb2fa1d64e141a7b9f02be85407f3d151f19d3abe0c39009d389fe7a3c095541fd604b13f0ce63e6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b8e4f6e4e3237b24aa13394ae288fea5e1e8af31ad0aadcf06eba787db6ca62f5ca3266f6164fd5a849baa038085aaca5d0fc504f16b279060b5bff91880cc47"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-19 09:59:37.475393) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-19 09:59:37.475724) ========= 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=6dbc10da6d83fee962c624be000001a8-1474302692.58684-1942397390 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004500 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-19 09:59:37.558328) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-19 09:59:37.558661) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-19 09:59:37.558968) ========= ========= Total master_lag: 0.15 =========