builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-011 starttime: 1477601521.07 results: success (0) buildid: 20161027110534 builduid: 58109e52ec42484c8b4ac57bdfcbc1d6 revision: 829a3f99f2606759305e3db204185242566a4ca6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-27 13:52:01.073673) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-27 13:52:01.074193) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-27 13:52:01.074677) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-27 13:52:01.089755) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 13:52:01.090083) ========= 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=5cf47e208febbcd81da23b2e0000026f-1477601520.353984-1583879947 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-27 13:52:01-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 19.8M=0.001s 2016-10-27 13:52:01 (19.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.099939 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 13:52:01.203790) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 13:52:01.204100) ========= 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=5cf47e208febbcd81da23b2e0000026f-1477601520.353984-1583879947 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016742 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 13:52:01.253767) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-27 13:52:01.254134) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 829a3f99f2606759305e3db204185242566a4ca6 --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 829a3f99f2606759305e3db204185242566a4ca6 --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=5cf47e208febbcd81da23b2e0000026f-1477601520.353984-1583879947 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-27 13:52:01,336 truncating revision to first 12 chars 2016-10-27 13:52:01,336 Setting DEBUG logging. 2016-10-27 13:52:01,336 attempt 1/10 2016-10-27 13:52:01,336 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/829a3f99f260?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-27 13:52:02,861 unpacking tar archive at: mozilla-beta-829a3f99f260/testing/mozharness/ program finished with exit code 0 elapsedTime=1.850303 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-27 13:52:03.118128) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-27 13:52:03.118467) ========= script_repo_revision: 829a3f99f2606759305e3db204185242566a4ca6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-27 13:52:03.118844) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-27 13:52:03.119105) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-27 13:52:03.128262) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 57 secs) (at 2016-10-27 13:52:03.128654) ========= /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=5cf47e208febbcd81da23b2e0000026f-1477601520.353984-1583879947 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:52:03 INFO - MultiFileLogger online at 20161027 13:52:03 in /builds/slave/test 13:52:03 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 13:52:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:52:03 INFO - {'append_to_log': False, 13:52:03 INFO - 'base_work_dir': '/builds/slave/test', 13:52:03 INFO - 'blob_upload_branch': 'Mozilla-Beta', 13:52:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:52:03 INFO - 'branch': 'Mozilla-Beta', 13:52:03 INFO - 'buildbot_json_path': 'buildprops.json', 13:52:03 INFO - 'config_files': ('talos/linux_config.py',), 13:52:03 INFO - 'default_actions': ('clobber', 13:52:03 INFO - 'read-buildbot-config', 13:52:03 INFO - 'download-and-extract', 13:52:03 INFO - 'populate-webroot', 13:52:03 INFO - 'create-virtualenv', 13:52:03 INFO - 'install', 13:52:03 INFO - 'run-tests'), 13:52:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:52:03 INFO - 'download_minidump_stackwalk': True, 13:52:03 INFO - 'download_symbols': 'ondemand', 13:52:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:52:03 INFO - 'tooltool.py': '/tools/tooltool.py', 13:52:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:52:03 INFO - '/tools/misc-python/virtualenv.py')}, 13:52:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:52:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:52:03 INFO - 'installer_path': 'installer.exe', 13:52:03 INFO - 'log_level': 'info', 13:52:03 INFO - 'log_name': 'talos', 13:52:03 INFO - 'log_to_console': True, 13:52:03 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:52:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:52:03 INFO - 'opt_config_files': (), 13:52:03 INFO - 'pip_index': False, 13:52:03 INFO - 'sps_profile': False, 13:52:03 INFO - 'sps_profile_interval': 0, 13:52:03 INFO - 'suite': 'dromaeojs-e10s', 13:52:03 INFO - 'system_bits': '32', 13:52:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:52:03 INFO - 'title': 'talos-linux64-ix-011', 13:52:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:52:03 INFO - 'use_talos_json': True, 13:52:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:52:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:52:03 INFO - 'work_dir': 'build'} 13:52:03 INFO - [mozharness: 2016-10-27 20:52:03.304795Z] Running clobber step. 13:52:03 INFO - Running pre-action listener: _resource_record_pre_action 13:52:03 INFO - Running main action method: clobber 13:52:03 INFO - rmtree: /builds/slave/test/build 13:52:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:52:04 INFO - Running post-action listener: _resource_record_post_action 13:52:04 INFO - [mozharness: 2016-10-27 20:52:04.275557Z] Finished clobber step (success) 13:52:04 INFO - [mozharness: 2016-10-27 20:52:04.275658Z] Running read-buildbot-config step. 13:52:04 INFO - Running pre-action listener: _resource_record_pre_action 13:52:04 INFO - Running main action method: read_buildbot_config 13:52:04 INFO - Using buildbot properties: 13:52:04 INFO - { 13:52:04 INFO - "project": "", 13:52:04 INFO - "product": "firefox", 13:52:04 INFO - "script_repo_revision": "production", 13:52:04 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 13:52:04 INFO - "repository": "", 13:52:04 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 13:52:04 INFO - "buildid": "20161027110534", 13:52:04 INFO - "pgo_build": "True", 13:52:04 INFO - "basedir": "/builds/slave/test", 13:52:04 INFO - "buildnumber": 307, 13:52:04 INFO - "slavename": "talos-linux64-ix-011", 13:52:04 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 13:52:04 INFO - "platform": "ubuntu64_hw", 13:52:04 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 13:52:04 INFO - "branch": "mozilla-beta", 13:52:04 INFO - "repo_path": "releases/mozilla-beta", 13:52:04 INFO - "revision": "829a3f99f2606759305e3db204185242566a4ca6", 13:52:04 INFO - "stage_platform": "linux64-pgo", 13:52:04 INFO - "builduid": "58109e52ec42484c8b4ac57bdfcbc1d6", 13:52:04 INFO - "slavebuilddir": "test" 13:52:04 INFO - } 13:52:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/NyUhgzcFQOORyptSJ-OXQg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2. 13:52:04 INFO - Running post-action listener: _resource_record_post_action 13:52:04 INFO - [mozharness: 2016-10-27 20:52:04.278074Z] Finished read-buildbot-config step (success) 13:52:04 INFO - [mozharness: 2016-10-27 20:52:04.278162Z] Running download-and-extract step. 13:52:04 INFO - Running pre-action listener: _resource_record_pre_action 13:52:04 INFO - Running main action method: download_and_extract 13:52:04 INFO - mkdir: /builds/slave/test/build/tests 13:52:04 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')]} 13:52:04 INFO - https://queue.taskcluster.net/v1/task/NyUhgzcFQOORyptSJ-OXQg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 13:52:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyUhgzcFQOORyptSJ-OXQg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 13:52:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyUhgzcFQOORyptSJ-OXQg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 13:52:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyUhgzcFQOORyptSJ-OXQg/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 13:52:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyUhgzcFQOORyptSJ-OXQg/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 13:52:04 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyUhgzcFQOORyptSJ-OXQg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 13:52:04 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 13:52:04 INFO - retry: Failed, sleeping 30 seconds before retrying 13:52:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyUhgzcFQOORyptSJ-OXQg/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 13:52:34 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyUhgzcFQOORyptSJ-OXQg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 13:52:34 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 13:52:34 INFO - retry: Failed, sleeping 60 seconds before retrying 13:53:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyUhgzcFQOORyptSJ-OXQg/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 13:53:34 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyUhgzcFQOORyptSJ-OXQg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 13:53:34 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 13:53:34 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyUhgzcFQOORyptSJ-OXQg/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! 13:53:34 INFO - Caught exception: HTTP Error 404: Not Found 13:53:34 INFO - Caught exception: HTTP Error 404: Not Found 13:53:34 INFO - Caught exception: HTTP Error 404: Not Found 13:53:34 INFO - trying https://queue.taskcluster.net/v1/task/NyUhgzcFQOORyptSJ-OXQg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 13:53:34 INFO - Downloading https://queue.taskcluster.net/v1/task/NyUhgzcFQOORyptSJ-OXQg/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 13:53:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NyUhgzcFQOORyptSJ-OXQg/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 13:53:34 INFO - Downloaded 1327 bytes. 13:53:34 INFO - Reading from file /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 13:53:34 INFO - Using the following test package requirements: 13:53:34 INFO - {u'common': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'], 13:53:34 INFO - u'cppunittest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 13:53:34 INFO - u'firefox-50.0.en-US.linux-x86_64.cppunittest.tests.zip'], 13:53:34 INFO - u'gtest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 13:53:34 INFO - u'firefox-50.0.en-US.linux-x86_64.gtest.tests.zip'], 13:53:34 INFO - u'jittest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 13:53:34 INFO - u'jsshell-linux-x86_64.zip'], 13:53:34 INFO - u'mochitest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 13:53:34 INFO - u'firefox-50.0.en-US.linux-x86_64.mochitest.tests.zip'], 13:53:34 INFO - u'mozbase': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'], 13:53:34 INFO - u'reftest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 13:53:34 INFO - u'firefox-50.0.en-US.linux-x86_64.reftest.tests.zip'], 13:53:34 INFO - u'talos': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 13:53:34 INFO - u'firefox-50.0.en-US.linux-x86_64.talos.tests.zip'], 13:53:34 INFO - u'web-platform': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 13:53:34 INFO - u'firefox-50.0.en-US.linux-x86_64.web-platform.tests.zip'], 13:53:34 INFO - u'xpcshell': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 13:53:34 INFO - u'firefox-50.0.en-US.linux-x86_64.xpcshell.tests.zip']} 13:53:34 INFO - Downloading packages: [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:53:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:53:34 INFO - https://queue.taskcluster.net/v1/task/NyUhgzcFQOORyptSJ-OXQg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:53:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyUhgzcFQOORyptSJ-OXQg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 13:53:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyUhgzcFQOORyptSJ-OXQg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 13:53:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyUhgzcFQOORyptSJ-OXQg/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 13:53:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyUhgzcFQOORyptSJ-OXQg/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 13:53:34 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyUhgzcFQOORyptSJ-OXQg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 13:53:34 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 13:53:34 INFO - retry: Failed, sleeping 30 seconds before retrying 13:54:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyUhgzcFQOORyptSJ-OXQg/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 13:54:05 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyUhgzcFQOORyptSJ-OXQg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 13:54:05 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 13:54:05 INFO - retry: Failed, sleeping 60 seconds before retrying 13:55:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyUhgzcFQOORyptSJ-OXQg/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 13:55:05 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyUhgzcFQOORyptSJ-OXQg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 13:55:05 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 13:55:05 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyUhgzcFQOORyptSJ-OXQg/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! 13:55:05 INFO - Caught exception: HTTP Error 404: Not Found 13:55:05 INFO - Caught exception: HTTP Error 404: Not Found 13:55:05 INFO - Caught exception: HTTP Error 404: Not Found 13:55:05 INFO - trying https://queue.taskcluster.net/v1/task/NyUhgzcFQOORyptSJ-OXQg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 13:55:05 INFO - Downloading https://queue.taskcluster.net/v1/task/NyUhgzcFQOORyptSJ-OXQg/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 13:55:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NyUhgzcFQOORyptSJ-OXQg/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 13:55:05 INFO - Downloaded 21789075 bytes. 13:55:05 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'] 13:55:05 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 13:55:07 INFO - Return code: 0 13:55:07 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 13:55:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:55:07 INFO - https://queue.taskcluster.net/v1/task/NyUhgzcFQOORyptSJ-OXQg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:55:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyUhgzcFQOORyptSJ-OXQg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 13:55:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyUhgzcFQOORyptSJ-OXQg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 13:55:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyUhgzcFQOORyptSJ-OXQg/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 13:55:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyUhgzcFQOORyptSJ-OXQg/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 13:55:07 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyUhgzcFQOORyptSJ-OXQg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 13:55:07 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 13:55:07 INFO - retry: Failed, sleeping 30 seconds before retrying 13:55:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyUhgzcFQOORyptSJ-OXQg/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 13:55:37 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyUhgzcFQOORyptSJ-OXQg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 13:55:37 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 13:55:37 INFO - retry: Failed, sleeping 60 seconds before retrying 13:56:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyUhgzcFQOORyptSJ-OXQg/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 13:56:37 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyUhgzcFQOORyptSJ-OXQg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 13:56:37 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 13:56:37 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyUhgzcFQOORyptSJ-OXQg/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! 13:56:37 INFO - Caught exception: HTTP Error 404: Not Found 13:56:37 INFO - Caught exception: HTTP Error 404: Not Found 13:56:37 INFO - Caught exception: HTTP Error 404: Not Found 13:56:37 INFO - trying https://queue.taskcluster.net/v1/task/NyUhgzcFQOORyptSJ-OXQg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 13:56:37 INFO - Downloading https://queue.taskcluster.net/v1/task/NyUhgzcFQOORyptSJ-OXQg/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 13:56:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NyUhgzcFQOORyptSJ-OXQg/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 13:56:38 INFO - Downloaded 21789075 bytes. 13:56:38 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'] 13:56:38 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 13:56:39 INFO - Return code: 0 13:56: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')]} 13:56:39 INFO - https://queue.taskcluster.net/v1/task/NyUhgzcFQOORyptSJ-OXQg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:56:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyUhgzcFQOORyptSJ-OXQg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 13:56:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyUhgzcFQOORyptSJ-OXQg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 13:56:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyUhgzcFQOORyptSJ-OXQg/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 13:56:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyUhgzcFQOORyptSJ-OXQg/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 13:56:39 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyUhgzcFQOORyptSJ-OXQg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 13:56:39 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 13:56:39 INFO - retry: Failed, sleeping 30 seconds before retrying 13:57:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyUhgzcFQOORyptSJ-OXQg/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 13:57:09 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyUhgzcFQOORyptSJ-OXQg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 13:57:09 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 13:57:09 INFO - retry: Failed, sleeping 60 seconds before retrying 13:58:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyUhgzcFQOORyptSJ-OXQg/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 13:58:09 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyUhgzcFQOORyptSJ-OXQg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 13:58:09 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 13:58:09 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyUhgzcFQOORyptSJ-OXQg/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! 13:58:09 INFO - Caught exception: HTTP Error 404: Not Found 13:58:09 INFO - Caught exception: HTTP Error 404: Not Found 13:58:09 INFO - Caught exception: HTTP Error 404: Not Found 13:58:09 INFO - trying https://queue.taskcluster.net/v1/task/NyUhgzcFQOORyptSJ-OXQg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 13:58:09 INFO - Downloading https://queue.taskcluster.net/v1/task/NyUhgzcFQOORyptSJ-OXQg/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 13:58:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NyUhgzcFQOORyptSJ-OXQg/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 13:58:10 INFO - Downloaded 14413762 bytes. 13:58:10 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'] 13:58:10 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 13:58:10 INFO - Return code: 0 13:58:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:58:10 INFO - https://queue.taskcluster.net/v1/task/NyUhgzcFQOORyptSJ-OXQg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:58:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyUhgzcFQOORyptSJ-OXQg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 13:58:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyUhgzcFQOORyptSJ-OXQg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 13:58:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyUhgzcFQOORyptSJ-OXQg/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 13:58:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyUhgzcFQOORyptSJ-OXQg/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 13:58:10 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyUhgzcFQOORyptSJ-OXQg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 13:58:10 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 13:58:10 INFO - retry: Failed, sleeping 30 seconds before retrying 13:58:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyUhgzcFQOORyptSJ-OXQg/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 13:58:40 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyUhgzcFQOORyptSJ-OXQg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 13:58:40 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 13:58:40 INFO - retry: Failed, sleeping 60 seconds before retrying 13:59:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyUhgzcFQOORyptSJ-OXQg/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 13:59:40 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyUhgzcFQOORyptSJ-OXQg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 13:59:40 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 13:59:40 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyUhgzcFQOORyptSJ-OXQg/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! 13:59:40 INFO - Caught exception: HTTP Error 404: Not Found 13:59:40 INFO - Caught exception: HTTP Error 404: Not Found 13:59:40 INFO - Caught exception: HTTP Error 404: Not Found 13:59:40 INFO - trying https://queue.taskcluster.net/v1/task/NyUhgzcFQOORyptSJ-OXQg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 13:59:40 INFO - Downloading https://queue.taskcluster.net/v1/task/NyUhgzcFQOORyptSJ-OXQg/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 13:59:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NyUhgzcFQOORyptSJ-OXQg/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 13:59:41 INFO - Downloaded 56813882 bytes. 13:59:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NyUhgzcFQOORyptSJ-OXQg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 13:59:41 INFO - mkdir: /builds/slave/test/properties 13:59:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:59:41 INFO - Writing to file /builds/slave/test/properties/build_url 13:59:41 INFO - Contents: 13:59:41 INFO - build_url:https://queue.taskcluster.net/v1/task/NyUhgzcFQOORyptSJ-OXQg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 13:59:42 INFO - Running post-action listener: _resource_record_post_action 13:59:42 INFO - Running post-action listener: set_extra_try_arguments 13:59:42 INFO - [mozharness: 2016-10-27 20:59:42.408910Z] Finished download-and-extract step (success) 13:59:42 INFO - [mozharness: 2016-10-27 20:59:42.409141Z] Running populate-webroot step. 13:59:42 INFO - Running pre-action listener: _resource_record_pre_action 13:59:42 INFO - Running main action method: populate_webroot 13:59:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:59:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:59:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:59:42 INFO - '--tppagecycles', 13:59:42 INFO - '7'], 13:59:42 INFO - 'tests': ['tsvgm']}}, 13:59:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:59:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:59:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:59:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:59:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:59:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:59:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:59:42 INFO - 'talos_options': ['--disable-e10s'], 13:59:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:59:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:59:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:59:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:59:42 INFO - 'talos_options': ['--disable-e10s'], 13:59:42 INFO - 'tests': ['damp', 'tps']}, 13:59:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:59:42 INFO - 'tests': ['damp', 'tps']}, 13:59:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:59:42 INFO - 'tests': ['dromaeo_dom']}, 13:59:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:59:42 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:59:42 INFO - 'tests': ['basic_compositor_video']}, 13:59:42 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:59:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:59:42 INFO - 'tests': ['a11yr', 13:59:42 INFO - 'ts_paint', 13:59:42 INFO - 'tpaint', 13:59:42 INFO - 'sessionrestore', 13:59:42 INFO - 'sessionrestore_no_auto_restore', 13:59:42 INFO - 'tabpaint']}, 13:59:42 INFO - 'other-e10s': {'tests': ['a11yr', 13:59:42 INFO - 'ts_paint', 13:59:42 INFO - 'tpaint', 13:59:42 INFO - 'sessionrestore', 13:59:42 INFO - 'sessionrestore_no_auto_restore', 13:59:42 INFO - 'tabpaint']}, 13:59:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:59:42 INFO - 'ts_paint', 13:59:42 INFO - 'tpaint', 13:59:42 INFO - 'sessionrestore', 13:59:42 INFO - 'sessionrestore_no_auto_restore', 13:59:42 INFO - 'tabpaint']}, 13:59:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:59:42 INFO - 'ts_paint', 13:59:42 INFO - 'tpaint', 13:59:42 INFO - 'sessionrestore', 13:59:42 INFO - 'sessionrestore_no_auto_restore', 13:59:42 INFO - 'tabpaint']}, 13:59:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:59:42 INFO - 'tests': ['a11yr', 13:59:42 INFO - 'ts_paint', 13:59:42 INFO - 'tpaint', 13:59:42 INFO - 'sessionrestore', 13:59:42 INFO - 'sessionrestore_no_auto_restore', 13:59:42 INFO - 'tabpaint']}, 13:59:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:59:42 INFO - 'tests': ['a11yr', 13:59:42 INFO - 'ts_paint', 13:59:42 INFO - 'tpaint', 13:59:42 INFO - 'sessionrestore', 13:59:42 INFO - 'sessionrestore_no_auto_restore', 13:59:42 INFO - 'tabpaint']}, 13:59:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:59:42 INFO - 'tests': ['tsvgx', 13:59:42 INFO - 'tsvgr_opacity', 13:59:42 INFO - 'tart', 13:59:42 INFO - 'tscrollx', 13:59:42 INFO - 'cart']}, 13:59:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:59:42 INFO - 'tsvgr_opacity', 13:59:42 INFO - 'tart', 13:59:42 INFO - 'tscrollx', 13:59:42 INFO - 'cart']}, 13:59:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:59:42 INFO - 'talos_options': ['--disable-e10s'], 13:59:42 INFO - 'tests': ['tp5o']}, 13:59:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:59:42 INFO - 'tests': ['tp5o']}, 13:59:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:59:42 INFO - 'talos_options': ['--disable-e10s', 13:59:42 INFO - '--xperf_path', 13:59:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:59:42 INFO - 'tests': ['tp5n']}, 13:59:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:59:42 INFO - 'talos_options': ['--xperf_path', 13:59:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:59:42 INFO - 'tests': ['tp5n']}}, 13:59:42 INFO - 'talos.zip': {'path': '', 13:59:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:59:42 INFO - Running post-action listener: _resource_record_post_action 13:59:42 INFO - [mozharness: 2016-10-27 20:59:42.431818Z] Finished populate-webroot step (success) 13:59:42 INFO - [mozharness: 2016-10-27 20:59:42.431906Z] Running create-virtualenv step. 13:59:42 INFO - Running pre-action listener: _resource_record_pre_action 13:59:42 INFO - Running main action method: create_virtualenv 13:59:42 INFO - Creating virtualenv /builds/slave/test/build/venv 13:59:42 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 13:59:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:59:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:59:42 INFO - Using real prefix '/usr' 13:59:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:59:43 INFO - Installing distribute.............................................................................................................................................................................................done. 13:59:44 INFO - Installing pip.................done. 13:59:45 INFO - Return code: 0 13:59:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:59:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:59:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:59:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:59:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:59:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29dd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c0c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c9b570>, '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 0x2c9c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c9c900>, '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': '5cf47e208febbcd81da23b2e0000026f-1477601520.353984-1583879947', '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 13:59:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 13:59:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:59:45 INFO - Using env: {'DISPLAY': ':0', 13:59:45 INFO - 'HOME': '/home/cltbld', 13:59:45 INFO - 'LANG': 'en_US.UTF-8', 13:59:45 INFO - 'LANGUAGE': 'en_US:en', 13:59:45 INFO - 'LOGNAME': 'cltbld', 13:59:45 INFO - 'MAIL': '/var/mail/cltbld', 13:59:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:59:45 INFO - 'MOZ_NO_REMOTE': '1', 13:59:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:59:45 INFO - 'NO_EM_RESTART': '1', 13:59:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:59:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:59:45 INFO - 'PWD': '/builds/slave/test', 13:59:45 INFO - 'SHELL': '/bin/bash', 13:59:45 INFO - 'SHLVL': '1', 13:59:45 INFO - 'TERM': 'linux', 13:59:45 INFO - 'TMOUT': '86400', 13:59:45 INFO - 'USER': 'cltbld', 13:59:45 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1477601520.353984-1583879947', 13:59:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:59:45 INFO - '_': '/tools/buildbot/bin/python'} 13:59:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:59:45 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 13:59:45 INFO - Cleaning up... 13:59:45 INFO - Return code: 0 13:59:45 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:59:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:59:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:59:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:59:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:59:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x29dd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c0c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c9b570>, '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 0x2c9c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c9c900>, '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': '5cf47e208febbcd81da23b2e0000026f-1477601520.353984-1583879947', '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 13:59:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 13:59:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 13:59:45 INFO - Using env: {'DISPLAY': ':0', 13:59:45 INFO - 'HOME': '/home/cltbld', 13:59:45 INFO - 'LANG': 'en_US.UTF-8', 13:59:45 INFO - 'LANGUAGE': 'en_US:en', 13:59:45 INFO - 'LOGNAME': 'cltbld', 13:59:45 INFO - 'MAIL': '/var/mail/cltbld', 13:59:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:59:45 INFO - 'MOZ_NO_REMOTE': '1', 13:59:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:59:45 INFO - 'NO_EM_RESTART': '1', 13:59:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:59:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:59:45 INFO - 'PWD': '/builds/slave/test', 13:59:45 INFO - 'SHELL': '/bin/bash', 13:59:45 INFO - 'SHLVL': '1', 13:59:45 INFO - 'TERM': 'linux', 13:59:45 INFO - 'TMOUT': '86400', 13:59:45 INFO - 'USER': 'cltbld', 13:59:45 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1477601520.353984-1583879947', 13:59:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:59:45 INFO - '_': '/tools/buildbot/bin/python'} 13:59:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:59:45 INFO - Downloading/unpacking psutil>=3.1.1 13:59:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:59:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:59:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:59:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:59:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:59:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:59:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:59:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:59:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:59:47 INFO - Installing collected packages: psutil 13:59:47 INFO - Running setup.py install for psutil 13:59:47 INFO - building 'psutil._psutil_linux' extension 13:59:47 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 13:59:47 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 13:59:47 INFO - building 'psutil._psutil_posix' extension 13:59:47 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 13:59:47 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 13:59:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:59:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:59:47 INFO - Successfully installed psutil 13:59:47 INFO - Cleaning up... 13:59:48 INFO - Return code: 0 13:59:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:59:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:59:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:59:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:59:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:59:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29dd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c0c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c9b570>, '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 0x2c9c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c9c900>, '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': '5cf47e208febbcd81da23b2e0000026f-1477601520.353984-1583879947', '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 13:59:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 13:59:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 13:59:48 INFO - Using env: {'DISPLAY': ':0', 13:59:48 INFO - 'HOME': '/home/cltbld', 13:59:48 INFO - 'LANG': 'en_US.UTF-8', 13:59:48 INFO - 'LANGUAGE': 'en_US:en', 13:59:48 INFO - 'LOGNAME': 'cltbld', 13:59:48 INFO - 'MAIL': '/var/mail/cltbld', 13:59:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:59:48 INFO - 'MOZ_NO_REMOTE': '1', 13:59:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:59:48 INFO - 'NO_EM_RESTART': '1', 13:59:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:59:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:59:48 INFO - 'PWD': '/builds/slave/test', 13:59:48 INFO - 'SHELL': '/bin/bash', 13:59:48 INFO - 'SHLVL': '1', 13:59:48 INFO - 'TERM': 'linux', 13:59:48 INFO - 'TMOUT': '86400', 13:59:48 INFO - 'USER': 'cltbld', 13:59:48 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1477601520.353984-1583879947', 13:59:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:59:48 INFO - '_': '/tools/buildbot/bin/python'} 13:59:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:59:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:59:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:59:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:59:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:59:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:59:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:59:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:59:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:59:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:59:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:59:50 INFO - Installing collected packages: mozsystemmonitor 13:59:50 INFO - Running setup.py install for mozsystemmonitor 13:59:50 INFO - Successfully installed mozsystemmonitor 13:59:50 INFO - Cleaning up... 13:59:50 INFO - Return code: 0 13:59:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:59: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')]} 13:59:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:59:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59: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')]} 13:59:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:59:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:50 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 0x29dd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c0c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c9b570>, '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 0x2c9c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c9c900>, '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': '5cf47e208febbcd81da23b2e0000026f-1477601520.353984-1583879947', '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 13:59:50 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 13:59:50 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 13:59:50 INFO - Using env: {'DISPLAY': ':0', 13:59:50 INFO - 'HOME': '/home/cltbld', 13:59:50 INFO - 'LANG': 'en_US.UTF-8', 13:59:50 INFO - 'LANGUAGE': 'en_US:en', 13:59:50 INFO - 'LOGNAME': 'cltbld', 13:59:50 INFO - 'MAIL': '/var/mail/cltbld', 13:59:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:59:50 INFO - 'MOZ_NO_REMOTE': '1', 13:59:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:59:50 INFO - 'NO_EM_RESTART': '1', 13:59:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:59:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:59:50 INFO - 'PWD': '/builds/slave/test', 13:59:50 INFO - 'SHELL': '/bin/bash', 13:59:50 INFO - 'SHLVL': '1', 13:59:50 INFO - 'TERM': 'linux', 13:59:50 INFO - 'TMOUT': '86400', 13:59:50 INFO - 'USER': 'cltbld', 13:59:50 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1477601520.353984-1583879947', 13:59:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:59:50 INFO - '_': '/tools/buildbot/bin/python'} 13:59:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:59:50 INFO - Downloading/unpacking jsonschema==2.5.1 13:59:50 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 13:59:50 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 13:59:50 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 13:59:50 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 13:59:50 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 13:59:50 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 13:59:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:59:52 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:59:52 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 13:59:52 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 13:59:52 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 13:59:52 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 13:59:52 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 13:59:52 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 13:59:52 INFO - Downloading functools32-3.2.3-2.tar.gz 13:59:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:59:52 INFO - warning: no files found matching '*.txt' 13:59:52 INFO - no previously-included directories found matching 'build' 13:59:52 INFO - no previously-included directories found matching 'dist' 13:59:52 INFO - no previously-included directories found matching '.git*' 13:59:52 INFO - Installing collected packages: jsonschema, functools32 13:59:52 INFO - Running setup.py install for functools32 13:59:52 INFO - warning: no files found matching '*.txt' 13:59:52 INFO - no previously-included directories found matching 'build' 13:59:52 INFO - no previously-included directories found matching 'dist' 13:59:52 INFO - no previously-included directories found matching '.git*' 13:59:52 INFO - Successfully installed jsonschema functools32 13:59:52 INFO - Cleaning up... 13:59:52 INFO - Return code: 0 13:59:52 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:59:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:59:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:59:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:59:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:59:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:52 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 0x29dd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c0c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c9b570>, '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 0x2c9c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c9c900>, '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': '5cf47e208febbcd81da23b2e0000026f-1477601520.353984-1583879947', '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 13:59:52 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 13:59:52 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 13:59:52 INFO - Using env: {'DISPLAY': ':0', 13:59:52 INFO - 'HOME': '/home/cltbld', 13:59:52 INFO - 'LANG': 'en_US.UTF-8', 13:59:52 INFO - 'LANGUAGE': 'en_US:en', 13:59:52 INFO - 'LOGNAME': 'cltbld', 13:59:52 INFO - 'MAIL': '/var/mail/cltbld', 13:59:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:59:52 INFO - 'MOZ_NO_REMOTE': '1', 13:59:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:59:52 INFO - 'NO_EM_RESTART': '1', 13:59:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:59:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:59:52 INFO - 'PWD': '/builds/slave/test', 13:59:52 INFO - 'SHELL': '/bin/bash', 13:59:52 INFO - 'SHLVL': '1', 13:59:52 INFO - 'TERM': 'linux', 13:59:52 INFO - 'TMOUT': '86400', 13:59:52 INFO - 'USER': 'cltbld', 13:59:52 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1477601520.353984-1583879947', 13:59:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:59:52 INFO - '_': '/tools/buildbot/bin/python'} 13:59:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:59:53 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:59:53 INFO - Cleaning up... 13:59:53 INFO - Return code: 0 13:59:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:59:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:59:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:59:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:59:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:59:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x29dd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c0c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c9b570>, '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 0x2c9c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c9c900>, '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': '5cf47e208febbcd81da23b2e0000026f-1477601520.353984-1583879947', '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 13:59:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:59:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:59:53 INFO - Using env: {'DISPLAY': ':0', 13:59:53 INFO - 'HOME': '/home/cltbld', 13:59:53 INFO - 'LANG': 'en_US.UTF-8', 13:59:53 INFO - 'LANGUAGE': 'en_US:en', 13:59:53 INFO - 'LOGNAME': 'cltbld', 13:59:53 INFO - 'MAIL': '/var/mail/cltbld', 13:59:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:59:53 INFO - 'MOZ_NO_REMOTE': '1', 13:59:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:59:53 INFO - 'NO_EM_RESTART': '1', 13:59:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:59:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:59:53 INFO - 'PWD': '/builds/slave/test', 13:59:53 INFO - 'SHELL': '/bin/bash', 13:59:53 INFO - 'SHLVL': '1', 13:59:53 INFO - 'TERM': 'linux', 13:59:53 INFO - 'TMOUT': '86400', 13:59:53 INFO - 'USER': 'cltbld', 13:59:53 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1477601520.353984-1583879947', 13:59:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:59:53 INFO - '_': '/tools/buildbot/bin/python'} 13:59:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:59:53 INFO - Downloading/unpacking blobuploader==1.2.4 13:59:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:59:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:59:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:59:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:59:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:59:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:59:55 INFO - Downloading blobuploader-1.2.4.tar.gz 13:59:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:59:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:59:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:59:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:59:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:59:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:59:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:59:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:59:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:59:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:59:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:59:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:59:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:59:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:59:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:59:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:59:55 INFO - Downloading docopt-0.6.1.tar.gz 13:59:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:59:56 INFO - Installing collected packages: blobuploader, requests, docopt 13:59:56 INFO - Running setup.py install for blobuploader 13:59:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:59:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:59:56 INFO - Running setup.py install for requests 13:59:56 INFO - Running setup.py install for docopt 13:59:56 INFO - Successfully installed blobuploader requests docopt 13:59:56 INFO - Cleaning up... 13:59:56 INFO - Return code: 0 13:59:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:59:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:59:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:59:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:59:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:59:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:56 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 0x29dd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c0c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c9b570>, '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 0x2c9c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c9c900>, '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': '5cf47e208febbcd81da23b2e0000026f-1477601520.353984-1583879947', '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 13:59:56 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 13:59:56 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 13:59:56 INFO - Using env: {'DISPLAY': ':0', 13:59:56 INFO - 'HOME': '/home/cltbld', 13:59:56 INFO - 'LANG': 'en_US.UTF-8', 13:59:56 INFO - 'LANGUAGE': 'en_US:en', 13:59:56 INFO - 'LOGNAME': 'cltbld', 13:59:56 INFO - 'MAIL': '/var/mail/cltbld', 13:59:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:59:56 INFO - 'MOZ_NO_REMOTE': '1', 13:59:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:59:56 INFO - 'NO_EM_RESTART': '1', 13:59:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:59:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:59:56 INFO - 'PWD': '/builds/slave/test', 13:59:56 INFO - 'SHELL': '/bin/bash', 13:59:56 INFO - 'SHLVL': '1', 13:59:56 INFO - 'TERM': 'linux', 13:59:56 INFO - 'TMOUT': '86400', 13:59:56 INFO - 'USER': 'cltbld', 13:59:56 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1477601520.353984-1583879947', 13:59:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:59:56 INFO - '_': '/tools/buildbot/bin/python'} 13:59:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:59:56 INFO - Running setup.py (path:/tmp/pip-XQUOlq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:59:56 INFO - Running setup.py (path:/tmp/pip-EGuG0i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:59:57 INFO - Running setup.py (path:/tmp/pip-Mg2wHw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:59:57 INFO - Running setup.py (path:/tmp/pip-6P_t4t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:59:57 INFO - Running setup.py (path:/tmp/pip-8_MVMW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:59:57 INFO - Running setup.py (path:/tmp/pip-vlr3uf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:59:57 INFO - Running setup.py (path:/tmp/pip-CVvF2Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:59:57 INFO - Running setup.py (path:/tmp/pip-UEkV2P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:59:57 INFO - Running setup.py (path:/tmp/pip-vFxdgY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:59:57 INFO - Running setup.py (path:/tmp/pip-_zJNDI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:59:57 INFO - Running setup.py (path:/tmp/pip-IN3zUC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:59:57 INFO - Running setup.py (path:/tmp/pip-6K9ewK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:59:57 INFO - Running setup.py (path:/tmp/pip-zuKWQQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:59:57 INFO - Running setup.py (path:/tmp/pip-frBh3N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:59:57 INFO - Running setup.py (path:/tmp/pip-07vnie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:59:57 INFO - Running setup.py (path:/tmp/pip-aQAwQZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:59:58 INFO - Running setup.py (path:/tmp/pip-koKnt6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:59:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:59:58 INFO - Running setup.py install for manifestparser 13:59:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:59:58 INFO - Running setup.py install for mozcrash 13:59:58 INFO - Running setup.py install for mozdebug 13:59:58 INFO - Running setup.py install for mozdevice 13:59:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:59:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:59:58 INFO - Running setup.py install for mozfile 13:59:58 INFO - Running setup.py install for mozhttpd 13:59:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:59:58 INFO - Running setup.py install for mozinfo 13:59:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:59:58 INFO - Running setup.py install for mozInstall 13:59:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:59:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:59:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:59:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:59:58 INFO - Running setup.py install for mozleak 13:59:59 INFO - Running setup.py install for mozlog 13:59:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:59:59 INFO - Running setup.py install for moznetwork 13:59:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:59:59 INFO - Running setup.py install for mozprocess 13:59:59 INFO - Running setup.py install for mozprofile 13:59:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:59:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:59:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:59:59 INFO - Running setup.py install for mozrunner 13:59:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:59:59 INFO - Running setup.py install for mozscreenshot 13:59:59 INFO - Running setup.py install for moztest 13:59:59 INFO - Running setup.py install for mozversion 13:59:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:59:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:59:59 INFO - Cleaning up... 13:59:59 INFO - Return code: 0 13:59:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:59:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:59:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:59:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:59:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:59:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:59 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 0x29dd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c0c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c9b570>, '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 0x2c9c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c9c900>, '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': '5cf47e208febbcd81da23b2e0000026f-1477601520.353984-1583879947', '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 13:59:59 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 13:59:59 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 13:59:59 INFO - Using env: {'DISPLAY': ':0', 13:59:59 INFO - 'HOME': '/home/cltbld', 13:59:59 INFO - 'LANG': 'en_US.UTF-8', 13:59:59 INFO - 'LANGUAGE': 'en_US:en', 13:59:59 INFO - 'LOGNAME': 'cltbld', 13:59:59 INFO - 'MAIL': '/var/mail/cltbld', 13:59:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:59:59 INFO - 'MOZ_NO_REMOTE': '1', 13:59:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:59:59 INFO - 'NO_EM_RESTART': '1', 13:59:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:59:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:59:59 INFO - 'PWD': '/builds/slave/test', 13:59:59 INFO - 'SHELL': '/bin/bash', 13:59:59 INFO - 'SHLVL': '1', 13:59:59 INFO - 'TERM': 'linux', 13:59:59 INFO - 'TMOUT': '86400', 13:59:59 INFO - 'USER': 'cltbld', 13:59:59 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1477601520.353984-1583879947', 13:59:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:59:59 INFO - '_': '/tools/buildbot/bin/python'} 14:00:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:00:00 INFO - Running setup.py (path:/tmp/pip-8D6vPD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:00:00 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)) 14:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:00:00 INFO - Running setup.py (path:/tmp/pip-lWkqkw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:00:00 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)) 14:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:00:00 INFO - Running setup.py (path:/tmp/pip-NBYNRY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:00:00 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)) 14:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:00:00 INFO - Running setup.py (path:/tmp/pip-1Nnkdo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:00:00 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)) 14:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:00:00 INFO - Running setup.py (path:/tmp/pip-iDzB5o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:00:00 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)) 14:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:00:00 INFO - Running setup.py (path:/tmp/pip-i2mb7g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:00:00 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)) 14:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:00:00 INFO - Running setup.py (path:/tmp/pip-gZdF0t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:00:00 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)) 14:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:00:00 INFO - Running setup.py (path:/tmp/pip-h_L7vM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:00:00 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)) 14:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:00:00 INFO - Running setup.py (path:/tmp/pip-VjVAA3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:00:00 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)) 14:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:00:00 INFO - Running setup.py (path:/tmp/pip-dt8sxJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:00:00 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)) 14:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:00:00 INFO - Running setup.py (path:/tmp/pip-K2Ffnd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:00:00 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)) 14:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:00:00 INFO - Running setup.py (path:/tmp/pip-XkecAn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:00:01 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)) 14:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:00:01 INFO - Running setup.py (path:/tmp/pip-hQ8CiC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:00:01 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)) 14:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:00:01 INFO - Running setup.py (path:/tmp/pip-KoqMd1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:00:01 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)) 14:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:00:01 INFO - Running setup.py (path:/tmp/pip-Qfl4Aj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:00:01 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)) 14:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:00:01 INFO - Running setup.py (path:/tmp/pip-0i8xFm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:00:01 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)) 14:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:00:01 INFO - Running setup.py (path:/tmp/pip-YeFcTW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:00:01 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)) 14:00:01 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)) 14:00:01 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)) 14:00:01 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)) 14:00:01 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)) 14:00:01 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)) 14:00:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:00:01 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 14:00:01 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 14:00:01 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 14:00:01 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 14:00:01 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 14:00:01 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 14:00:03 INFO - Downloading blessings-1.6.tar.gz 14:00:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:00:03 INFO - Installing collected packages: blessings 14:00:03 INFO - Running setup.py install for blessings 14:00:03 INFO - Successfully installed blessings 14:00:03 INFO - Cleaning up... 14:00:03 INFO - Return code: 0 14:00:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:00:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:00:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:00:03 INFO - Reading from file tmpfile_stdout 14:00:03 INFO - Current package versions: 14:00:03 INFO - argparse == 1.2.1 14:00:03 INFO - blessings == 1.6 14:00:03 INFO - blobuploader == 1.2.4 14:00:03 INFO - docopt == 0.6.1 14:00:03 INFO - functools32 == 3.2.3-2 14:00:03 INFO - jsonschema == 2.5.1 14:00:03 INFO - manifestparser == 1.1 14:00:03 INFO - mozInstall == 1.12 14:00:03 INFO - mozcrash == 0.17 14:00:03 INFO - mozdebug == 0.1 14:00:03 INFO - mozdevice == 0.48 14:00:03 INFO - mozfile == 1.2 14:00:03 INFO - mozhttpd == 0.7 14:00:03 INFO - mozinfo == 0.9 14:00:03 INFO - mozleak == 0.1 14:00:03 INFO - mozlog == 3.3 14:00:03 INFO - moznetwork == 0.27 14:00:03 INFO - mozprocess == 0.23 14:00:03 INFO - mozprofile == 0.28 14:00:03 INFO - mozrunner == 6.12 14:00:03 INFO - mozscreenshot == 0.1 14:00:03 INFO - mozsystemmonitor == 0.3 14:00:03 INFO - moztest == 0.7 14:00:03 INFO - mozversion == 1.4 14:00:03 INFO - psutil == 3.1.1 14:00:03 INFO - requests == 1.2.3 14:00:03 INFO - wsgiref == 0.1.2 14:00:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:00:03 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')]} 14:00:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:00:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00:03 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')]} 14:00:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:00:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00:03 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 0x29dd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c0c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c9b570>, '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 0x2c9c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c9c900>, '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': '5cf47e208febbcd81da23b2e0000026f-1477601520.353984-1583879947', '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 14:00:03 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 14:00:03 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 14:00:03 INFO - Using env: {'DISPLAY': ':0', 14:00:03 INFO - 'HOME': '/home/cltbld', 14:00:03 INFO - 'LANG': 'en_US.UTF-8', 14:00:03 INFO - 'LANGUAGE': 'en_US:en', 14:00:03 INFO - 'LOGNAME': 'cltbld', 14:00:03 INFO - 'MAIL': '/var/mail/cltbld', 14:00:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:00:03 INFO - 'MOZ_NO_REMOTE': '1', 14:00:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:00:03 INFO - 'NO_EM_RESTART': '1', 14:00:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:00:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:00:03 INFO - 'PWD': '/builds/slave/test', 14:00:03 INFO - 'SHELL': '/bin/bash', 14:00:03 INFO - 'SHLVL': '1', 14:00:03 INFO - 'TERM': 'linux', 14:00:03 INFO - 'TMOUT': '86400', 14:00:03 INFO - 'USER': 'cltbld', 14:00:03 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1477601520.353984-1583879947', 14:00:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:00:03 INFO - '_': '/tools/buildbot/bin/python'} 14:00:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:00:03 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)) 14:00:04 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)) 14:00:04 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)) 14:00:04 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)) 14:00:04 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)) 14:00:04 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)) 14:00:04 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)) 14:00:04 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)) 14:00:04 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)) 14:00:04 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)) 14:00:04 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)) 14:00:04 INFO - Cleaning up... 14:00:04 INFO - Return code: 0 14:00:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:00:04 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')]} 14:00:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:00:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00:04 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')]} 14:00:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:00:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00:04 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 0x29dd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c0c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c9b570>, '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 0x2c9c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c9c900>, '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': '5cf47e208febbcd81da23b2e0000026f-1477601520.353984-1583879947', '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 14:00:04 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 14:00:04 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 14:00:04 INFO - Using env: {'DISPLAY': ':0', 14:00:04 INFO - 'HOME': '/home/cltbld', 14:00:04 INFO - 'LANG': 'en_US.UTF-8', 14:00:04 INFO - 'LANGUAGE': 'en_US:en', 14:00:04 INFO - 'LOGNAME': 'cltbld', 14:00:04 INFO - 'MAIL': '/var/mail/cltbld', 14:00:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:00:04 INFO - 'MOZ_NO_REMOTE': '1', 14:00:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:00:04 INFO - 'NO_EM_RESTART': '1', 14:00:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:00:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:00:04 INFO - 'PWD': '/builds/slave/test', 14:00:04 INFO - 'SHELL': '/bin/bash', 14:00:04 INFO - 'SHLVL': '1', 14:00:04 INFO - 'TERM': 'linux', 14:00:04 INFO - 'TMOUT': '86400', 14:00:04 INFO - 'USER': 'cltbld', 14:00:04 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1477601520.353984-1583879947', 14:00:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:00:04 INFO - '_': '/tools/buildbot/bin/python'} 14:00:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:00:04 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:00:04 INFO - Cleaning up... 14:00:04 INFO - Return code: 0 14:00:04 INFO - Running post-action listener: _resource_record_post_action 14:00:04 INFO - Running post-action listener: _start_resource_monitoring 14:00:04 INFO - Starting resource monitoring. 14:00:04 INFO - [mozharness: 2016-10-27 21:00:04.278286Z] Finished create-virtualenv step (success) 14:00:04 INFO - [mozharness: 2016-10-27 21:00:04.278717Z] Running install step. 14:00:04 INFO - Running pre-action listener: _resource_record_pre_action 14:00:04 INFO - Running main action method: install 14:00:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:00:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:00:04 INFO - Reading from file tmpfile_stdout 14:00:04 INFO - Detecting whether we're running mozinstall >=1.0... 14:00:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:00:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:00:04 INFO - Reading from file tmpfile_stdout 14:00:04 INFO - Output received: 14:00:04 INFO - Usage: mozinstall [options] installer 14:00:04 INFO - Options: 14:00:04 INFO - -h, --help show this help message and exit 14:00:04 INFO - -d DEST, --destination=DEST 14:00:04 INFO - Directory to install application into. [default: 14:00:04 INFO - "/builds/slave/test"] 14:00:04 INFO - --app=APP Application being installed. [default: firefox] 14:00:04 INFO - mkdir: /builds/slave/test/build/application 14:00:04 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'] 14:00:04 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 14:00:18 INFO - Reading from file tmpfile_stdout 14:00:18 INFO - Output received: 14:00:18 INFO - /builds/slave/test/build/application/firefox/firefox 14:00:18 INFO - Running post-action listener: _resource_record_post_action 14:00:18 INFO - [mozharness: 2016-10-27 21:00:18.072011Z] Finished install step (success) 14:00:18 INFO - [mozharness: 2016-10-27 21:00:18.072293Z] Running run-tests step. 14:00:18 INFO - Running pre-action listener: _resource_record_pre_action 14:00:18 INFO - Running main action method: run_tests 14:00:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:00:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:00:18 INFO - Python 2.7.3 14:00:18 INFO - Return code: 0 14:00:18 INFO - grabbing minidump binary from tooltool 14:00:18 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')]} 14:00:18 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 0x2c9b570>, '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 0x2c9c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c9c900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:00:18 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 14:00:18 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 14:00:18 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 14:00:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:00:18 INFO - Return code: 0 14:00:18 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:00:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:00:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:00:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:00:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:00:18 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/NyUhgzcFQOORyptSJ-OXQg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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 14:00:18 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/NyUhgzcFQOORyptSJ-OXQg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-011 --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 14:00:18 INFO - Using env: {'DISPLAY': ':0', 14:00:18 INFO - 'HOME': '/home/cltbld', 14:00:18 INFO - 'LANG': 'en_US.UTF-8', 14:00:18 INFO - 'LANGUAGE': 'en_US:en', 14:00:18 INFO - 'LOGNAME': 'cltbld', 14:00:18 INFO - 'MAIL': '/var/mail/cltbld', 14:00:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:00:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:00:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:00:18 INFO - 'MOZ_NO_REMOTE': '1', 14:00:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:00:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:00:18 INFO - 'NO_EM_RESTART': '1', 14:00:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:00:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:00:18 INFO - 'PWD': '/builds/slave/test', 14:00:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:00:18 INFO - 'SHELL': '/bin/bash', 14:00:18 INFO - 'SHLVL': '1', 14:00:18 INFO - 'TERM': 'linux', 14:00:18 INFO - 'TMOUT': '86400', 14:00:18 INFO - 'USER': 'cltbld', 14:00:18 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1477601520.353984-1583879947', 14:00:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:00:18 INFO - '_': '/tools/buildbot/bin/python'} 14:00:18 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/NyUhgzcFQOORyptSJ-OXQg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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 14:00:18 INFO - mozversion application_buildid: 20161027110534 14:00:18 INFO - mozversion application_changeset: 829a3f99f2606759305e3db204185242566a4ca6 14:00:18 INFO - mozversion application_display_name: Firefox 14:00:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:00:18 INFO - mozversion application_name: Firefox 14:00:18 INFO - mozversion application_remotingname: firefox 14:00:18 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 14:00:18 INFO - mozversion application_vendor: Mozilla 14:00:18 INFO - mozversion application_version: 50.0 14:00:18 INFO - mozversion platform_buildid: 20161027110534 14:00:18 INFO - mozversion platform_changeset: 829a3f99f2606759305e3db204185242566a4ca6 14:00:18 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 14:00:18 INFO - mozversion platform_version: 50.0 14:00:18 INFO - using testdate: 1477602018 14:00:18 INFO - actual date: 1477602018 14:00:18 INFO - starting webserver on 'localhost:53592' 14:00:18 INFO - SUITE-START | Running 2 tests 14:00:18 INFO - TEST-START | dromaeo_css 14:00:18 INFO - operating with platform_type : linux_ 14:00:18 INFO - Initialising browser for dromaeo_css test... 14:00:18 INFO - TEST-INFO | started process 9820 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_3ppkZ/profile http://localhost:53592/getInfo.html) 14:00:23 INFO - PROCESS | 9820 | __metrics Screen width/height:1600/1200 14:00:23 INFO - PROCESS | 9820 | colorDepth:24 14:00:23 INFO - PROCESS | 9820 | Browser inner width/height: 1024/697 14:00:23 INFO - PROCESS | 9820 | __metrics 14:00:24 ERROR - PROCESS | 9820 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 14:00:25 INFO - TEST-INFO | 9820: exit 0 14:00:25 INFO - Browser initialized. 14:00:25 INFO - Running cycle 1/1 for dromaeo_css test... 14:00:25 INFO - TEST-INFO | started process 9943 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_3ppkZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:00:37 INFO - PROCESS | 9943 | RSS: Main: 150368256 14:00:37 INFO - PROCESS | 9943 | 14:01:27 INFO - PROCESS | 9943 | 1477602087144 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] 14:03:35 INFO - PROCESS | 9943 | Cycle 1(1): loaded http://localhost:53592/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53592/tests/dromaeo/cssquery-ext.html) 14:03:36 INFO - PROCESS | 9943 | RSS: Main: 158949376 14:03:36 INFO - PROCESS | 9943 | 14:06:38 INFO - PROCESS | 9943 | Cycle 1(1): loaded http://localhost:53592/tests/dromaeo/cssquery-ext.html (next: http://localhost:53592/tests/dromaeo/cssquery-jquery.html) 14:06:39 INFO - PROCESS | 9943 | RSS: Main: 155963392 14:06:39 INFO - PROCESS | 9943 | 14:09:40 INFO - PROCESS | 9943 | Cycle 1(1): loaded http://localhost:53592/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53592/tests/dromaeo/cssquery-mootools.html) 14:09:41 INFO - PROCESS | 9943 | RSS: Main: 155394048 14:09:41 INFO - PROCESS | 9943 | 14:12:43 INFO - PROCESS | 9943 | Cycle 1(1): loaded http://localhost:53592/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53592/tests/dromaeo/cssquery-prototype.html) 14:12:43 INFO - PROCESS | 9943 | RSS: Main: 157081600 14:12:43 INFO - PROCESS | 9943 | 14:15:46 INFO - PROCESS | 9943 | Cycle 1(1): loaded http://localhost:53592/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53592/tests/dromaeo/cssquery-yui.html) 14:15:46 INFO - PROCESS | 9943 | RSS: Main: 158011392 14:15:46 INFO - PROCESS | 9943 | 14:18:49 INFO - PROCESS | 9943 | Cycle 1(1): loaded http://localhost:53592/tests/dromaeo/cssquery-yui.html (next: http://localhost:53592/tests/dromaeo/cssquery-dojo.html) 14:18:49 INFO - PROCESS | 9943 | RSS: Main: 157954048 14:18:49 INFO - PROCESS | 9943 | 14:18:49 INFO - PROCESS | 9943 | __start_tp_report 14:18:49 INFO - PROCESS | 9943 | _x_x_mozilla_page_load 14:18:49 INFO - PROCESS | 9943 | _x_x_mozilla_page_load_details 14:18:49 INFO - PROCESS | 9943 | |i|pagename|runs| 14:18:49 INFO - PROCESS | 9943 | |0;dojo.html;3169.540416639586;3188.728958038567;3205.727513161381;3318.203631128529;3321.7342612590987;5766.798162064329;5769.8269051928455;5791.21818554495;5838.766449342026;5857.4435428634315;5637.069883469223;5809;5812.128180772876;5814.156947242647;5836.824895253149;5257.263983042368;5314.3091398118195;5324.787008519655;5339.733013349336;5377.381601115882;5355.491228333302;5360.812371566996;5371.301730774994;5375.43557926418;5399;5048.469910659383;5076.822311219108;5352.357717073956;5360.061989151883;5374.274472946141;5188.8702782430555;5202.921956170641;5272.789088436496;5349.7592608332325;5378.542823859977;5236.947630523722;5297.17893726473;5313.7608807603365;5320.733963301858;5345;5602.215689803431;5766.394528574523;5775.5957083004205;5837.562182836262;5915.08316210988;6121.265448146207;6128.717018009216;6142.6007309525185;6234.0337247726675;6247.2815626202655;6273.404026617464;6274.780382686584;6275.780347687809;6276.560640755149;6278.78024269153;5643.858903527444;5867.823965281048;5868.061110222344;5879.32387775407;5907.9704601476715;6158.661273629993;6189.752409903554;6207.472364849038;6302.369763023661;6309.716062777186;6015.879682406327;6065.878682426415;6068.696565171724;6070.910139394308;6118.20463339763;6036.124761909498;6091.786787462506;6147.907781383283;6159.076138579159;6167.414095660905;6101.725422356005;6111.77406523465;6136.417040381157;6229.813105606839;6244.625322480575;6199.938000620026;6201.348858369896;6210.31686514483;6212.47193988507;6237.438630523184;4592.931106033412;4758.381410416624;4765.213739732905;4770.785314660849;4781.784819683123;4111.362738775495;4124.443200167999;4155.667546596265;4157.438745769343;4194.328907374806;5931.139984702194;5965.343812180657;5972.283326000907;5974.283086029617;5976.103584462366;5979.073243647242;6233.812985610439;6243.719032643542;6248;6254.9687251563455;5866.794662186889;5930.911036334458;5937.168796368512;5996.940030599725;5999.580029397987;5368.892622147535;5377;5383.973080134574;5386.353637563518;5388.649737767033;6150.7847225346895;6297.4017468340435;6496.577722448026;6499.05763664266;6507.251666058464;6165.136880836597;6300.464460520724;6309.990401535732;6310.085037669604;6315.621062736067;6468.935310647022;6525.477961762953;6526.282108968105;6530.118434011348;6549.967250163719;5877.235959325431;5930.970345148246;6148.200733904564;6150.600210986271;6174.413430724074;6064.3935606439;6117.063650123533;6134.467201660849;6134.957077261001;6144.938550614436;5969.940300596939;5986;5987.43119403656;6000.849978750566;6030.6080104793045;5828.854278643068;5854.736536855767;5948.970255148696;5951.285845698544;5963.880722385615;5977.671228082323;6028.367021462858;6094.421030002142;6105.725242364193;6108.5723999319625;6065.575409721454;6076.513878889767;6121.755129794758;6140.478059365004;6158.784442544489;5779.566532510163;5981.342052374148;6000.849978750566;6016.548758843017;6028.788992385421 14:18:49 INFO - PROCESS | 9943 | |1;ext.html;591.0897218283841;641.2657507154308;663.8539521305314;667.3726696904911;692.4460431654675;43013;47548.2867756983;47549.28676069862;47650.76174619122;47696.52303476964;47071.29393059107;47491.52508474923;47495.52504474954;47515.049699006;47619.28571071428;9100.226480749145;9221.907780922173;9240.722778316627;9250.07499250073;9258.166764991149;9156.679516216935;9232;9246.26029917605;9281.257499400032;9282.164605185531;9261.6295348186;9324.62701491943;9325.114114159143;9336.953315233415;9341.112594303564;9191.540422978824;9231.076892310783;9273.258139348836;9276.118768717028;9285.210757085655;9264.073592640749;9333.300002499771;9344.532773361372;9354.532273386303;9354.672586459441;44693.55306446959;44767;44855.327170092474;45026;45169.096618067786;3634.945475817865;4069.877903662895;4577.313402989545;4615.14619795339;4638.628909687217;34422.10805600567;35003.824980875186;35157.82421087904;35547.82226088879;35548.28903421943;4737.928931066037;4745.454272758642;4774.785134668913;4789.592884604813;4793.7363445010515;361519;361582;362244;362693;363130;64159.67920160369;64755;64833;64863.67568162223;64933.67533162304;40371.59628403737;40612.39081413781;40777.98055048648;43775;68856;15335.693286134216;15348;15467.303971321093;15490.380384784483;15492.380304787683;11047.889521104686;11094.5562177512;11097.500612472459;11102.000819926085;11116.722081948015;20981;21269.68095478569;21334.35996920095;21400.35798926035;21414.464638384165;7526.661300241502;7544.886826697604;7659.234076592296;7749;7828.334591559667;1025.564135242534;1065.5151905882806;1083.9620613278498;1151.8214676724954;1192.2131393280392;34702.65297346994;34735.652643473244;35137.648623513436;35254.82372588121;35454.468182977274;1095;1148.0872706198593;1154.520873837365;1191.8951132300413;1241.1436109084702;17971.640567188584;18560.814391855907;18563.721544176577;18565.535861603297;18791.530211744543;586412;588012;590960;594016;596707;64135.35864641387;64774;64865.35134648593;65123.67438162779;65224.67387663126;1427.4504315838476;1462.4004158295047;1470.0003997281738;1470.2795630141154;1477.8300495442948;32576;34137.31725365528;34150.14624634404;34663.65336346705;35018.649813501535;57016;61082.69458652856;63156;63258;67317.32682673307;562851;565002;566298;568663;570913;48894.51105488899;49183.26225106555;49459.25811112908;49652.50347496479;50246.748766255936;53255.46744532505;53849;54076;54174.72912635569;54257.45742542682;45857;46465.767671161426;47218.76390618025;47485.287720683526;47920.2811957814;47333.52666473429;47531.28703069388;47551.52448475471;47838;48680;39741.205175896896;43786.78106609447;44158.11683766243;46389.07221855612;46669.29996049994;39859.80070099631;41591.58408415877;41767;41775;42060;30891.382172355978;30933.381332373676;31266;31462;31678.524822127227 14:18:49 INFO - PROCESS | 9943 | |2;jquery.html;420.8842568293717;422.6567848319791;436.5132876842322;441.2719013627515;443.19559998602534;19471.902640486795;21081.894590527027;21149.471263218427;22094.558108837853;22319.10723571059;20017.799822001776;20305.796942030574;20412.69380959283;20433.182672693074;20574.897125514388;5894.557908156884;6107.7556897724035;6129.111278864562;6151.323354431009;6167.044108163242;6057.151998720183;6070.908936365936;6098.08528720691;6115.87768244637;6122.142899994004;5832.329282132567;5937.079752638348;5987.4311940365815;5992.310884248302;6003.849903752397;5930.703464826763;5940.405959404068;5965.135055416984;5969.492593129546;5982.790602328898;5306.204069389584;5320.866978325535;5338.733063346817;5359.517643412073;5375.408705042442;24643.260702178963;25534.23397298084;25668.10161644352;25693.486130277477;25694.87152564244;2722.5916112583072;2723.196656986194;2751.3946931675;3089.3666798306294;3163.509656003323;15768.76346854798;16038.278277477542;16050.197490125563;16259.837401625951;16426.342946282133;2001.8798872067723;2061.8762874227446;2103.8632488888325;2130.9573808523896;2139.4865232344127;86319;87160.12839871584;88609;88725.55637221837;90386.54806725924;11479.827802582968;11842.644720658394;12227;12791.104622676323;12890.677733056562;16964.982101073976;16966.660666786596;16975.405860794814;16978.49064528066;17002.23489942931;8144.389170812213;8236.876446853303;8320.958395207985;8356.415050946376;8419.516242708292;7755.689772409153;7811.765647030485;7814.452988290879;7949.960250198712;7970.880436793453;7171.342269954412;7193.89209161863;7221.602811845294;7272.163701174327;7312.341889229889;2068.214078650103;2174.923877664274;2179.1936983316273;2197.3847322749334;2204.74645415776;947.9146876781123;1037.419045334615;1077.450500244865;1111.288775183883;1202.458893497912;21414.78585214159;21448.892755536435;21487.247946321804;21530.03114859835;21558.784412155677;1066.57337065173;1076.5747529725716;1090.6618948126106;1102.079763397572;1156.919015668895;11268.830967535494;11871.406429678482;11924.642260732191;12232.633021009384;12239.388030598435;538130;544751;546786;548908;549232;104094;104104;107082;107889.46055269674;108360;1021.065724861758;1066.2056767707952;1072.3351522056375;1111.366521082991;1118.0608289037248;18631.161597728405;19135.52161195981;19161.90419047896;19239.903800480908;19357;44829.55170448254;45079.77460112678;46177.76911115423;46452.53547464482;46549;58171;66006.66996664986;66656;67515.3248467509;68030.3196968024;8241.381896357918;8461.576921154041;8645.394822362374;8796.120387961153;9470.47912364799;10265;13602.523911663044;14430.639234019234;14510.419583216553;14539.491117810825;12901.483940642269;12987.805182922453;12991.220526768424;13127.934360328138;13183.14309569875;11880.46537905779;12026.75946481083;12258.14193006481;12497.812532812197;12715.745685086431;12308.753824923631;12388.070894683115;13156.868431315565;13172.670683232996;13227.537036203687;8480.363972701949;8609.65561377538;8695.869561956702;8726.956365218133;8740.78148046304;9688.806223875625;11571.942140289244;11592.420378980849;13203.603891883258;13241.867581324064 14:18:49 INFO - PROCESS | 9943 | |3;mootools.html;1541.57606658169;1546.3814474210315;1759.9824001759978;1840.6686796376664;1868.6075924055947;8418.074011858705;9156.954215228914;9247.352685312031;9716.85424718629;9741.830980282359;9107.726768196948;9425.764355891106;9539.713808585737;9549.23606111511;9556.617735290598;2440.536298103359;2500.9124680636182;2502.074232533956;2507.2728908616477;2508.548461276969;2406.085687438771;2455.656208130863;2475.2945410557995;2481.2928315430104;2485.950280994379;2426.7815896569305;2441.5849305618;2469.3085935937966;2471.394508345458;2478.938026549333;2369.620860662286;2381.4760752634393;2383.2611890314056;2387.271882075966;2391.497785465054;2314.837961342707;2351.1888398502488;2358.339664893815;2360.822938279619;2368.928932132039;9614.75963100921;9641.614335426575;9679.370840895319;9728.41629502225;9728.951355243178;5500.944990550083;5504.091824848895;5549.72251387429;5549.833504994856;5721.485066344049;3532.6643968822923;3575.7496975211748;3607.749476944296;3643.4352675335367;3745.5879853216125;1259.5969289827258;1275.5649893869397;1290.5031562848278;1298.9415476303589;1313.2514466753953;13198.208107513485;13301.53444629443;13301.600951971457;13307;13318.400671969785;4791.976040119846;4846.466888642247;5013.197888337849;5028.591994241545;5065.3161823153405;11248.718782030352;11307.547698092148;11334.716632084264;11391;11400.144989125683;5669.716514174274;5695.345035320908;5722.856928576819;5726.599138060379;5739.713014349266;4702.36518070063;5062.367204099488;5160.277561141444;5200.947990520122;5227.555657769132;4310.073334233155;4335.436393268855;4401.2517871961845;4424.093060922503;4534.79593418297;1349.9932500337436;1366.3441548056987;1371.1704418826466;1372.457879137735;1417.0859795431888;1042.7497400623795;1051.1118105201092;1079.6491140379408;1083.4474418046852;1086.4187659602233;6239.220097487814;6308.369163083747;6455.7740479083;6468.838279043061;6596;476.21900083862494;480.7404001838968;482.8020511590231;492.33534728116757;494.44128135206984;4429.689921705514;4443.844465443694;4531.184386810406;4558.544145585415;4646.4191976003;11363.488643011084;11624.186306958432;11642;11706.414679266003;11719.531218751325;11594.6521604352;11782.293062416282;11831.290122592673;11936.104792140624;11962.581309654295;8423.747287581382;8723.956380218058;8856;8952.731418057469;8962.73111806647;6259.78090766821;6427.967860160669;6441.838954026187;6506.869862602816;6520.804375868732;10465.319754215952;10468.842967355344;10500.894991049992;10641.14870810318;10664.84002739975;10727.892721072689;10749.086327661924;10790.622328218475;10798.298110622783;10847.349159050482;8537.103604121477;8643.481391116553;8701.695440659547;8729.869051964099;8770.824583508422;9213.032631573587;9273.443593384418;9326.72019839406;9337.253019758267;9352.438853668802;8148.348132149533;8313.833723325379;8418.36862235347;8432.494050356752;8513.063563008189;8204.876926845982;8247.175282471704;8248.340132789242;8309.252167304972;8312.25189732927;7452.925470745223;7584.5070070445245;7599.734009309647;7599.88600171009;7603.2776886195725;5561.749721262634;5622.578306626938;5666.121751128417;5720.656760594377;5835.44563266489;5524.558035357242;5560.02699527573;5602.215689803512;5659.886802264014;5690.9430905690415 14:18:49 INFO - PROCESS | 9943 | |4;prototype.html;353.26697103510213;353.56158363629106;353.73469897576825;356.2358740501624;360.37295106514654;5691.402402747714;5755.827325180251;5814.796482123126;5935.228420305354;5937.604662904219;5781.4507621775865;5802.912956305659;5805.970970145154;5822.912656310159;5851.239338885939;4552.180607490651;4586.266197408415;4590.60979816716;4590.816367345302;4601.953980460203;4490.595846373826;4601.861944141664;4612.746298953556;4623.838165664202;4636.652251081166;4573.725576465406;4580.198465268565;4589.908201835978;4599.701019433743;4600.7929643166135;4569.451665800125;4574.529753932872;4596.97701511492;4612.86161415158;4632.930506042412;3764.3036038333;3924.7448915820382;3941.3496773032416;4118.794060296973;4121.649659778923;5578.219049333096;5602.803901863415;5610.523105536035;5669.546436285087;5685.493344263773;5152.68129341794;5165.302684137631;5179.19722443022;5180.948190518122;5184.481551844785;5788.913166302509;6019.969900150515;6061.757529698807;6071.939280607182;6085.330613632497;4355.499117601485;4355.673324500675;4364.956350436519;4374.125174964988;4375.190589740908;6181.598196117238;6338.58799178052;6343.365663433666;6375.330590288046;6416.550841441101;4405;4416.646668266595;4417.580329868657;4431.180231657154;4434.578715022068;4512.120136573402;4517.119161763425;4524.502304746476;4525.52481989393;4550.7497087660495;5106.821261255838;5162.483751624807;5207.843764687065;5209.47905209476;5216.556592689664;5944.64332140073;6037.335893051761;6060.696965151725;6084.391560843968;6105.198966304951;1543.1975372806078;1561.625209949604;1567.4357231396689;1567.5062355358025;1571.8035245594301;979.3193730357476;1009.1371877045168;1015.4516561056946;1015.5886865819355;1017.5065093429681;5174.922376164361;5184.662996905189;5217.321748172713;5236.842894713165;5294.629375943647;5431.479185827974;5511.5039646432015;5514.61397702157;5520.861978450491;5580.218769372291;5008.522485866678;5163.638545301793;5219.19102539107;5223.7910483580235;5240.6069544784295;2925.7074292570574;2947.675755666875;2955.527115661484;2960;2964.733174014349;5645.967451717378;5694.06401823382;5705.5720820938595;5719.54151691316;5765.221695071195;5236.895262094737;5493.285872836585;5517.475839795213;5531.585131115183;5532.28080349552;5637.661740295595;5640.32316122068;5673;5742.856428589319;5748.827535173951;5114.974425127851;5437.564994800327;5465.426130256265;5519.806806761905;5565.55475561946;5394.004218439202;5399.730013499231;5421.945780542144;5424.891502169856;5448.427915069019;5605;5678.84204002493;5715.428457154251;5744.281964754406;5758.2514273144225;3883.2815929053218;4016.879493615196;4026.2752704512295;4041.777702226406;4067.6983365323995;5413.025655382069;5474.452554744494;5528.226048353154;6110.7861224856915;6325.652089135142;6156.661383623944;6165.753369865155;6173.290071641819;6178.455386153461;6189.721462534287;6065.7573697053385;6146.907796382969;6147.938520614736;6193.411625895533;6242.843928901813;6110.694465276807;6122.908156377747;6138.600990935575;6167.259928808572;6168.167297414791;6221.9377806221355;6223.097650840693;6251.218597675291;6278.968605156945;6288.559800814082;5895.852603684943;6021.668808215591;6064.423879731418;6074.3014553325165;6117.877642447215 14:18:49 INFO - PROCESS | 9943 | |5;yui.html;822.1531822223109;841.9621117049733;855.5294587976612;873.7029410000598;942.3262367407302;16160.83839161608;16384.590385240375;16857.24142413591;16924.746128808078;17063.82936170638;15133.924330378333;15162.166080865549;15199.6960060799;15204.923975380108;15217.54347369578;867;877.5085951866959;889.915458031486;900.9774755631096;903.5075883643398;886.7206829848609;891.6121487153109;893.8748575199477;894.00318644711;894.9105089491064;928.5450129436562;931.4644079654225;932.2169377722712;932.5943214701626;933.6218831373304;917.7751450894507;919.9126083022102;922.967696130639;925.2181906289142;926.2636204217663;671.8253254153906;674.7739507265072;675.4731309578488;676.4250387170865;677.8305423644089;16082.919585401998;16150.111743854084;16170.919145404316;16195.352185912549;16242.187890605423;15345.923270383688;15420.46028389001;15430.228488575527;15536.844631553653;15728.685426291524;13865.930670346685;13878.722425551534;13885;13922.860771392257;14230.928845355811;4081.8367265309353;4111;4193.308104162809;4198.202341555126;4227.281362168439;83895.5805220976;87509.56245218797;88157.11842881617;88918;90745.54627226821;12223.694407639703;12780.424880880382;12894.161879477804;12962.157459765085;13012.934935325262;22732.31803045911;22821.429464263525;22835.429114271945;22943.770562294496;22980.65529017066;9345.841100710119;9683.757906052264;9684.181245591586;9829;9993.900060999442;5106.131957567222;5123.897522049613;5155.38135423744;5230.137027390438;5338.546223570962;3450.4996775467416;3531.6291789362263;3548.6983606393746;3549.574051113883;3690.1881586051027;675.5811396933932;686.7253098760535;691.0360047733384;691.4399336537421;702.8699690557263;739.6412739821183;754.1515794730927;758.893754874307;762.6225018615821;776.5263189454429;10017.949910250401;10508.632197873038;10580.89419105799;10659.786804264026;10835.079018283377;662.208660650518;679.9558028728117;706.6360824175554;775.5269285735696;776.5534817479971;4687.343771871941;4743.075100355398;4969.428515720666;5031.396232452129;5152.3044389007755;119358;121857;122290.3885480567;123822.38088809678;127119.36440317739;104174.25395782947;106250;106855;109131;111205;58617.41382586205;59655.40344596585;78520.60739696264;91931;94299.52850235841;10373.740656483647;10576.576936922436;10607.840882386925;10641.627543035956;10663.4135122569;54667.72666136644;54764.726176368866;55212.171817421964;55328.44671553233;56239;76226;83570;83943.58028210064;85075.5746221265;86113.56943215244;12592.244465332109;12776.297303648389;13209.669758255735;13295;13437.059405841497;14349.85650143527;14645.560633181021;14748.852511474748;14818.925905370405;14931.92534037323;13483.932580337036;13725.519606813714;13819;13929.30353482342;14641.780373294196;14058.859411405754;14204.928975355057;14426.42294308216;14614.926925365306;14702.705945881236;13552.457901683822;13692.863071369158;14698.265086745834;14739.336729846968;14761;11022.944885275843;11036.724081898017;11719.765604687687;11759.941200293944;11781;10589.470526473491;10638.680839574825;11748.29510229389;11787.528498859949;12120.333381664093 14:18:49 INFO - PROCESS | 9943 | __end_tp_report 14:18:49 INFO - PROCESS | 9943 | __start_cc_report 14:18:49 INFO - PROCESS | 9943 | _x_x_mozilla_cycle_collect,349 14:18:49 INFO - PROCESS | 9943 | __end_cc_report 14:18:49 INFO - PROCESS | 9943 | __startTimestamp1477603129381__endTimestamp 14:18:49 INFO - PROCESS | 9943 | 14:18:49 INFO - PROCESS | 9943 | ------- Summary: start ------- 14:18:49 INFO - PROCESS | 9943 | Number of tests: 6 14:18:49 INFO - PROCESS | 9943 | 14:18:49 INFO - PROCESS | 9943 | [#0] dojo.html Cycles:165 Average:5757.03 Median:5977.67 stddev:668.68 (11.2%) stddev-sans-first:639.18 14:18:49 INFO - PROCESS | 9943 | Values: 3169.5 3188.7 3205.7 3318.2 3321.7 5766.8 5769.8 5791.2 5838.8 5857.4 5637.1 5809.0 5812.1 5814.2 5836.8 5257.3 5314.3 5324.8 5339.7 5377.4 5355.5 5360.8 5371.3 5375.4 5399.0 5048.5 5076.8 5352.4 5360.1 5374.3 5188.9 5202.9 5272.8 5349.8 5378.5 5236.9 5297.2 5313.8 5320.7 5345.0 5602.2 5766.4 5775.6 5837.6 5915.1 6121.3 6128.7 6142.6 6234.0 6247.3 6273.4 6274.8 6275.8 6276.6 6278.8 5643.9 5867.8 5868.1 5879.3 5908.0 6158.7 6189.8 6207.5 6302.4 6309.7 6015.9 6065.9 6068.7 6070.9 6118.2 6036.1 6091.8 6147.9 6159.1 6167.4 6101.7 6111.8 6136.4 6229.8 6244.6 6199.9 6201.3 6210.3 6212.5 6237.4 4592.9 4758.4 4765.2 4770.8 4781.8 4111.4 4124.4 4155.7 4157.4 4194.3 5931.1 5965.3 5972.3 5974.3 5976.1 5979.1 6233.8 6243.7 6248.0 6255.0 5866.8 5930.9 5937.2 5996.9 5999.6 5368.9 5377.0 5384.0 5386.4 5388.6 6150.8 6297.4 6496.6 6499.1 6507.3 6165.1 6300.5 6310.0 6310.1 6315.6 6468.9 6525.5 6526.3 6530.1 6550.0 5877.2 5931.0 6148.2 6150.6 6174.4 6064.4 6117.1 6134.5 6135.0 6144.9 5969.9 5986.0 5987.4 6000.8 6030.6 5828.9 5854.7 5949.0 5951.3 5963.9 5977.7 6028.4 6094.4 6105.7 6108.6 6065.6 6076.5 6121.8 6140.5 6158.8 5779.6 5981.3 6000.8 6016.5 6028.8 14:18:49 INFO - PROCESS | 9943 | 14:18:49 INFO - PROCESS | 9943 | [#1] ext.html Cycles:180 Average:68085.21 Median:4741.69 stddev:137411.56 (2897.9%) stddev-sans-first:137703.59 14:18:49 INFO - PROCESS | 9943 | Values: 591.1 641.3 663.9 667.4 692.4 43013.0 47548.3 47549.3 47650.8 47696.5 47071.3 47491.5 47495.5 47515.0 47619.3 9100.2 9221.9 9240.7 9250.1 9258.2 9156.7 9232.0 9246.3 9281.3 9282.2 9261.6 9324.6 9325.1 9337.0 9341.1 9191.5 9231.1 9273.3 9276.1 9285.2 9264.1 9333.3 9344.5 9354.5 9354.7 44693.6 44767.0 44855.3 45026.0 45169.1 3634.9 4069.9 4577.3 4615.1 4638.6 34422.1 35003.8 35157.8 35547.8 35548.3 4737.9 4745.5 4774.8 4789.6 4793.7 361519.0 361582.0 362244.0 362693.0 363130.0 64159.7 64755.0 64833.0 64863.7 64933.7 40371.6 40612.4 40778.0 43775.0 68856.0 15335.7 15348.0 15467.3 15490.4 15492.4 11047.9 11094.6 11097.5 11102.0 11116.7 20981.0 21269.7 21334.4 21400.4 21414.5 7526.7 7544.9 7659.2 7749.0 7828.3 1025.6 1065.5 1084.0 1151.8 1192.2 34702.7 34735.7 35137.6 35254.8 35454.5 1095.0 1148.1 1154.5 1191.9 1241.1 17971.6 18560.8 18563.7 18565.5 18791.5 586412.0 588012.0 590960.0 594016.0 596707.0 64135.4 64774.0 64865.4 65123.7 65224.7 1427.5 1462.4 1470.0 1470.3 1477.8 32576.0 34137.3 34150.1 34663.7 35018.6 57016.0 61082.7 63156.0 63258.0 67317.3 562851.0 565002.0 566298.0 568663.0 570913.0 48894.5 49183.3 49459.3 49652.5 50246.7 53255.5 53849.0 54076.0 54174.7 54257.5 45857.0 46465.8 47218.8 47485.3 47920.3 47333.5 47531.3 47551.5 47838.0 48680.0 39741.2 43786.8 44158.1 46389.1 46669.3 39859.8 41591.6 41767.0 41775.0 42060.0 30891.4 30933.4 31266.0 31462.0 31678.5 14:18:49 INFO - PROCESS | 9943 | 14:18:49 INFO - PROCESS | 9943 | [#2] jquery.html Cycles:180 Average:32238.05 Median:12149.65 stddev:90038.34 (741.1%) stddev-sans-first:90259.22 14:18:49 INFO - PROCESS | 9943 | Values: 420.9 422.7 436.5 441.3 443.2 19471.9 21081.9 21149.5 22094.6 22319.1 20017.8 20305.8 20412.7 20433.2 20574.9 5894.6 6107.8 6129.1 6151.3 6167.0 6057.2 6070.9 6098.1 6115.9 6122.1 5832.3 5937.1 5987.4 5992.3 6003.8 5930.7 5940.4 5965.1 5969.5 5982.8 5306.2 5320.9 5338.7 5359.5 5375.4 24643.3 25534.2 25668.1 25693.5 25694.9 2722.6 2723.2 2751.4 3089.4 3163.5 15768.8 16038.3 16050.2 16259.8 16426.3 2001.9 2061.9 2103.9 2131.0 2139.5 86319.0 87160.1 88609.0 88725.6 90386.5 11479.8 11842.6 12227.0 12791.1 12890.7 16965.0 16966.7 16975.4 16978.5 17002.2 8144.4 8236.9 8321.0 8356.4 8419.5 7755.7 7811.8 7814.5 7950.0 7970.9 7171.3 7193.9 7221.6 7272.2 7312.3 2068.2 2174.9 2179.2 2197.4 2204.7 947.9 1037.4 1077.5 1111.3 1202.5 21414.8 21448.9 21487.2 21530.0 21558.8 1066.6 1076.6 1090.7 1102.1 1156.9 11268.8 11871.4 11924.6 12232.6 12239.4 538130.0 544751.0 546786.0 548908.0 549232.0 104094.0 104104.0 107082.0 107889.5 108360.0 1021.1 1066.2 1072.3 1111.4 1118.1 18631.2 19135.5 19161.9 19239.9 19357.0 44829.6 45079.8 46177.8 46452.5 46549.0 58171.0 66006.7 66656.0 67515.3 68030.3 8241.4 8461.6 8645.4 8796.1 9470.5 10265.0 13602.5 14430.6 14510.4 14539.5 12901.5 12987.8 12991.2 13127.9 13183.1 11880.5 12026.8 12258.1 12497.8 12715.7 12308.8 12388.1 13156.9 13172.7 13227.5 8480.4 8609.7 8695.9 8727.0 8740.8 9688.8 11571.9 11592.4 13203.6 13241.9 14:18:49 INFO - PROCESS | 9943 | 14:18:49 INFO - PROCESS | 9943 | [#3] mootools.html Cycles:180 Average:6243.35 Median:2589.29 stddev:3575.02 (138.1%) stddev-sans-first:3567.59 14:18:49 INFO - PROCESS | 9943 | Values: 1541.6 1546.4 1760.0 1840.7 1868.6 8418.1 9157.0 9247.4 9716.9 9741.8 9107.7 9425.8 9539.7 9549.2 9556.6 2440.5 2500.9 2502.1 2507.3 2508.5 2406.1 2455.7 2475.3 2481.3 2486.0 2426.8 2441.6 2469.3 2471.4 2478.9 2369.6 2381.5 2383.3 2387.3 2391.5 2314.8 2351.2 2358.3 2360.8 2368.9 9614.8 9641.6 9679.4 9728.4 9729.0 5500.9 5504.1 5549.7 5549.8 5721.5 3532.7 3575.7 3607.7 3643.4 3745.6 1259.6 1275.6 1290.5 1298.9 1313.3 13198.2 13301.5 13301.6 13307.0 13318.4 4792.0 4846.5 5013.2 5028.6 5065.3 11248.7 11307.5 11334.7 11391.0 11400.1 5669.7 5695.3 5722.9 5726.6 5739.7 4702.4 5062.4 5160.3 5200.9 5227.6 4310.1 4335.4 4401.3 4424.1 4534.8 1350.0 1366.3 1371.2 1372.5 1417.1 1042.7 1051.1 1079.6 1083.4 1086.4 6239.2 6308.4 6455.8 6468.8 6596.0 476.2 480.7 482.8 492.3 494.4 4429.7 4443.8 4531.2 4558.5 4646.4 11363.5 11624.2 11642.0 11706.4 11719.5 11594.7 11782.3 11831.3 11936.1 11962.6 8423.7 8724.0 8856.0 8952.7 8962.7 6259.8 6428.0 6441.8 6506.9 6520.8 10465.3 10468.8 10500.9 10641.1 10664.8 10727.9 10749.1 10790.6 10798.3 10847.3 8537.1 8643.5 8701.7 8729.9 8770.8 9213.0 9273.4 9326.7 9337.3 9352.4 8148.3 8313.8 8418.4 8432.5 8513.1 8204.9 8247.2 8248.3 8309.3 8312.3 7452.9 7584.5 7599.7 7599.9 7603.3 5561.7 5622.6 5666.1 5720.7 5835.4 5524.6 5560.0 5602.2 5659.9 5690.9 14:18:49 INFO - PROCESS | 9943 | 14:18:49 INFO - PROCESS | 9943 | [#4] prototype.html Cycles:180 Average:4926.96 Median:5428.19 stddev:1423.90 (26.2%) stddev-sans-first:1385.89 14:18:49 INFO - PROCESS | 9943 | Values: 353.3 353.6 353.7 356.2 360.4 5691.4 5755.8 5814.8 5935.2 5937.6 5781.5 5802.9 5806.0 5822.9 5851.2 4552.2 4586.3 4590.6 4590.8 4602.0 4490.6 4601.9 4612.7 4623.8 4636.7 4573.7 4580.2 4589.9 4599.7 4600.8 4569.5 4574.5 4597.0 4612.9 4632.9 3764.3 3924.7 3941.3 4118.8 4121.6 5578.2 5602.8 5610.5 5669.5 5685.5 5152.7 5165.3 5179.2 5180.9 5184.5 5788.9 6020.0 6061.8 6071.9 6085.3 4355.5 4355.7 4365.0 4374.1 4375.2 6181.6 6338.6 6343.4 6375.3 6416.6 4405.0 4416.6 4417.6 4431.2 4434.6 4512.1 4517.1 4524.5 4525.5 4550.7 5106.8 5162.5 5207.8 5209.5 5216.6 5944.6 6037.3 6060.7 6084.4 6105.2 1543.2 1561.6 1567.4 1567.5 1571.8 979.3 1009.1 1015.5 1015.6 1017.5 5174.9 5184.7 5217.3 5236.8 5294.6 5431.5 5511.5 5514.6 5520.9 5580.2 5008.5 5163.6 5219.2 5223.8 5240.6 2925.7 2947.7 2955.5 2960.0 2964.7 5646.0 5694.1 5705.6 5719.5 5765.2 5236.9 5493.3 5517.5 5531.6 5532.3 5637.7 5640.3 5673.0 5742.9 5748.8 5115.0 5437.6 5465.4 5519.8 5565.6 5394.0 5399.7 5421.9 5424.9 5448.4 5605.0 5678.8 5715.4 5744.3 5758.3 3883.3 4016.9 4026.3 4041.8 4067.7 5413.0 5474.5 5528.2 6110.8 6325.7 6156.7 6165.8 6173.3 6178.5 6189.7 6065.8 6146.9 6147.9 6193.4 6242.8 6110.7 6122.9 6138.6 6167.3 6168.2 6221.9 6223.1 6251.2 6279.0 6288.6 5895.9 6021.7 6064.4 6074.3 6117.9 14:18:49 INFO - PROCESS | 9943 | 14:18:49 INFO - PROCESS | 9943 | [#5] yui.html Cycles:180 Average:22094.13 Median:3491.06 stddev:31897.49 (913.7%) stddev-sans-first:31946.98 14:18:49 INFO - PROCESS | 9943 | Values: 822.2 842.0 855.5 873.7 942.3 16160.8 16384.6 16857.2 16924.7 17063.8 15133.9 15162.2 15199.7 15204.9 15217.5 867.0 877.5 889.9 901.0 903.5 886.7 891.6 893.9 894.0 894.9 928.5 931.5 932.2 932.6 933.6 917.8 919.9 923.0 925.2 926.3 671.8 674.8 675.5 676.4 677.8 16082.9 16150.1 16170.9 16195.4 16242.2 15345.9 15420.5 15430.2 15536.8 15728.7 13865.9 13878.7 13885.0 13922.9 14230.9 4081.8 4111.0 4193.3 4198.2 4227.3 83895.6 87509.6 88157.1 88918.0 90745.5 12223.7 12780.4 12894.2 12962.2 13012.9 22732.3 22821.4 22835.4 22943.8 22980.7 9345.8 9683.8 9684.2 9829.0 9993.9 5106.1 5123.9 5155.4 5230.1 5338.5 3450.5 3531.6 3548.7 3549.6 3690.2 675.6 686.7 691.0 691.4 702.9 739.6 754.2 758.9 762.6 776.5 10017.9 10508.6 10580.9 10659.8 10835.1 662.2 680.0 706.6 775.5 776.6 4687.3 4743.1 4969.4 5031.4 5152.3 119358.0 121857.0 122290.4 123822.4 127119.4 104174.3 106250.0 106855.0 109131.0 111205.0 58617.4 59655.4 78520.6 91931.0 94299.5 10373.7 10576.6 10607.8 10641.6 10663.4 54667.7 54764.7 55212.2 55328.4 56239.0 76226.0 83570.0 83943.6 85075.6 86113.6 12592.2 12776.3 13209.7 13295.0 13437.1 14349.9 14645.6 14748.9 14818.9 14931.9 13483.9 13725.5 13819.0 13929.3 14641.8 14058.9 14204.9 14426.4 14614.9 14702.7 13552.5 13692.9 14698.3 14739.3 14761.0 11022.9 11036.7 11719.8 11759.9 11781.0 10589.5 10638.7 11748.3 11787.5 12120.3 14:18:49 INFO - PROCESS | 9943 | -------- Summary: end -------- 14:18:49 INFO - PROCESS | 9943 | 14:18:50 INFO - TEST-INFO | 9943: exit 0 14:18:50 INFO - TEST-OK | dromaeo_css | took 1111889ms 14:18:50 INFO - TEST-START | kraken 14:18:50 INFO - operating with platform_type : linux_ 14:18:50 INFO - Initialising browser for kraken test... 14:18:50 INFO - TEST-INFO | started process 10186 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXHdlW2/profile http://localhost:53592/getInfo.html) 14:18:55 INFO - PROCESS | 10186 | __metrics Screen width/height:1600/1200 14:18:55 INFO - PROCESS | 10186 | colorDepth:24 14:18:55 INFO - PROCESS | 10186 | Browser inner width/height: 1024/697 14:18:55 INFO - PROCESS | 10186 | __metrics 14:18:56 ERROR - PROCESS | 10186 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 14:18:57 INFO - TEST-INFO | 10186: exit 0 14:18:57 INFO - Browser initialized. 14:18:57 INFO - Running cycle 1/1 for kraken test... 14:18:57 INFO - TEST-INFO | started process 10309 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXHdlW2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:19:08 INFO - PROCESS | 10309 | RSS: Main: 149979136 14:19:08 INFO - PROCESS | 10309 | 14:19:11 INFO - PROCESS | 10309 | Cycle 1(1): loaded http://localhost:53592/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53592/tests/kraken/driver.html?testName=audio-beat-detection) 14:19:12 INFO - PROCESS | 10309 | RSS: Main: 156659712 14:19:12 INFO - PROCESS | 10309 | 14:19:14 INFO - PROCESS | 10309 | Cycle 1(1): loaded http://localhost:53592/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53592/tests/kraken/driver.html?testName=audio-dft) 14:19:15 INFO - PROCESS | 10309 | RSS: Main: 155107328 14:19:15 INFO - PROCESS | 10309 | 14:19:18 INFO - PROCESS | 10309 | Cycle 1(1): loaded http://localhost:53592/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53592/tests/kraken/driver.html?testName=audio-fft) 14:19:18 INFO - PROCESS | 10309 | RSS: Main: 156471296 14:19:18 INFO - PROCESS | 10309 | 14:19:21 INFO - PROCESS | 10309 | Cycle 1(1): loaded http://localhost:53592/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53592/tests/kraken/driver.html?testName=audio-oscillator) 14:19:21 INFO - PROCESS | 10309 | RSS: Main: 155832320 14:19:21 INFO - PROCESS | 10309 | 14:19:23 INFO - PROCESS | 10309 | Cycle 1(1): loaded http://localhost:53592/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53592/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:19:24 INFO - PROCESS | 10309 | RSS: Main: 156082176 14:19:24 INFO - PROCESS | 10309 | 14:19:27 INFO - PROCESS | 10309 | Cycle 1(1): loaded http://localhost:53592/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53592/tests/kraken/driver.html?testName=imaging-darkroom) 14:19:28 INFO - PROCESS | 10309 | RSS: Main: 155406336 14:19:28 INFO - PROCESS | 10309 | 14:19:31 INFO - PROCESS | 10309 | Cycle 1(1): loaded http://localhost:53592/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53592/tests/kraken/driver.html?testName=imaging-desaturate) 14:19:32 INFO - PROCESS | 10309 | RSS: Main: 156397568 14:19:32 INFO - PROCESS | 10309 | 14:19:34 INFO - PROCESS | 10309 | Cycle 1(1): loaded http://localhost:53592/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53592/tests/kraken/driver.html?testName=json-parse-financial) 14:19:35 INFO - PROCESS | 10309 | RSS: Main: 155938816 14:19:35 INFO - PROCESS | 10309 | 14:19:37 INFO - PROCESS | 10309 | Cycle 1(1): loaded http://localhost:53592/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53592/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:19:37 INFO - PROCESS | 10309 | RSS: Main: 156086272 14:19:37 INFO - PROCESS | 10309 | 14:19:39 INFO - PROCESS | 10309 | Cycle 1(1): loaded http://localhost:53592/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53592/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:19:40 INFO - PROCESS | 10309 | RSS: Main: 156278784 14:19:40 INFO - PROCESS | 10309 | 14:19:42 INFO - PROCESS | 10309 | Cycle 1(1): loaded http://localhost:53592/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53592/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:19:42 INFO - PROCESS | 10309 | RSS: Main: 156520448 14:19:42 INFO - PROCESS | 10309 | 14:19:45 INFO - PROCESS | 10309 | Cycle 1(1): loaded http://localhost:53592/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53592/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:19:45 INFO - PROCESS | 10309 | RSS: Main: 156708864 14:19:45 INFO - PROCESS | 10309 | 14:19:48 INFO - PROCESS | 10309 | Cycle 1(1): loaded http://localhost:53592/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53592/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:19:49 INFO - PROCESS | 10309 | RSS: Main: 157380608 14:19:49 INFO - PROCESS | 10309 | 14:19:50 INFO - PROCESS | 10309 | Cycle 1(1): loaded http://localhost:53592/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53592/tests/kraken/driver.html?testName=ai-astar) 14:19:51 INFO - PROCESS | 10309 | RSS: Main: 158552064 14:19:51 INFO - PROCESS | 10309 | 14:19:51 INFO - PROCESS | 10309 | __start_tp_report 14:19:51 INFO - PROCESS | 10309 | _x_x_mozilla_page_load 14:19:51 INFO - PROCESS | 10309 | _x_x_mozilla_page_load_details 14:19:51 INFO - PROCESS | 10309 | |i|pagename|runs| 14:19:51 INFO - PROCESS | 10309 | |0;ai-astar;103;112;105;110;111;112;111;111;111;112 14:19:51 INFO - PROCESS | 10309 | |1;audio-beat-detection;145;124;145;170;116;147;140;123;168;120 14:19:51 INFO - PROCESS | 10309 | |2;audio-dft;161;163;162;164;162;162;161;161;162;161 14:19:51 INFO - PROCESS | 10309 | |3;audio-fft;74;75;76;175;77;76;75;78;182;74 14:19:51 INFO - PROCESS | 10309 | |4;audio-oscillator;83;84;154;83;83;82;151;83;83;144 14:19:51 INFO - PROCESS | 10309 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;117 14:19:51 INFO - PROCESS | 10309 | |6;imaging-darkroom;147;147;148;147;148;148;146;146;148;148 14:19:51 INFO - PROCESS | 10309 | |7;imaging-desaturate;95;95;95;95;95;96;95;95;95;95 14:19:51 INFO - PROCESS | 10309 | |8;json-parse-financial;51;51;52;52;53;52;51;51;52;56 14:19:51 INFO - PROCESS | 10309 | |9;json-stringify-tinderbox;59;59;62;60;60;59;60;60;63;59 14:19:51 INFO - PROCESS | 10309 | |10;stanford-crypto-aes;81;80;73;73;77;72;72;73;82;73 14:19:51 INFO - PROCESS | 10309 | |11;stanford-crypto-ccm;122;118;137;119;123;126;129;118;167;121 14:19:51 INFO - PROCESS | 10309 | |12;stanford-crypto-pbkdf2;154;151;154;151;154;149;153;154;152;149 14:19:51 INFO - PROCESS | 10309 | |13;stanford-crypto-sha256-iterative;63;61;63;63;70;60;59;61;60;59 14:19:51 INFO - PROCESS | 10309 | __end_tp_report 14:19:51 INFO - PROCESS | 10309 | __start_cc_report 14:19:51 INFO - PROCESS | 10309 | _x_x_mozilla_cycle_collect,876 14:19:51 INFO - PROCESS | 10309 | __end_cc_report 14:19:51 INFO - PROCESS | 10309 | __startTimestamp1477603191103__endTimestamp 14:19:51 INFO - PROCESS | 10309 | 14:19:51 INFO - PROCESS | 10309 | ------- Summary: start ------- 14:19:51 INFO - PROCESS | 10309 | Number of tests: 14 14:19:51 INFO - PROCESS | 10309 | 14:19:51 INFO - PROCESS | 10309 | [#0] ai-astar Cycles:10 Average:109.80 Median:111.00 stddev:3.16 (2.8%) stddev-sans-first:2.19 14:19:51 INFO - PROCESS | 10309 | Values: 103.0 112.0 105.0 110.0 111.0 112.0 111.0 111.0 111.0 112.0 14:19:51 INFO - PROCESS | 10309 | 14:19:51 INFO - PROCESS | 10309 | [#1] audio-beat-detection Cycles:10 Average:139.80 Median:145.00 stddev:19.16 (13.2%) stddev-sans-first:20.23 14:19:51 INFO - PROCESS | 10309 | Values: 145.0 124.0 145.0 170.0 116.0 147.0 140.0 123.0 168.0 120.0 14:19:51 INFO - PROCESS | 10309 | 14:19:51 INFO - PROCESS | 10309 | [#2] audio-dft Cycles:10 Average:161.90 Median:162.00 stddev:0.99 (0.6%) stddev-sans-first:1.00 14:19:51 INFO - PROCESS | 10309 | Values: 161.0 163.0 162.0 164.0 162.0 162.0 161.0 161.0 162.0 161.0 14:19:51 INFO - PROCESS | 10309 | 14:19:51 INFO - PROCESS | 10309 | [#3] audio-fft Cycles:10 Average:96.20 Median:75.50 stddev:43.43 (57.5%) stddev-sans-first:45.31 14:19:51 INFO - PROCESS | 10309 | Values: 74.0 75.0 76.0 175.0 77.0 76.0 75.0 78.0 182.0 74.0 14:19:51 INFO - PROCESS | 10309 | 14:19:51 INFO - PROCESS | 10309 | [#4] audio-oscillator Cycles:10 Average:103.00 Median:83.00 stddev:32.30 (38.9%) stddev-sans-first:33.44 14:19:51 INFO - PROCESS | 10309 | Values: 83.0 84.0 154.0 83.0 83.0 82.0 151.0 83.0 83.0 144.0 14:19:51 INFO - PROCESS | 10309 | 14:19:51 INFO - PROCESS | 10309 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 14:19:51 INFO - PROCESS | 10309 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 14:19:51 INFO - PROCESS | 10309 | 14:19:51 INFO - PROCESS | 10309 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:148.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 14:19:51 INFO - PROCESS | 10309 | Values: 147.0 147.0 148.0 147.0 148.0 148.0 146.0 146.0 148.0 148.0 14:19:51 INFO - PROCESS | 10309 | 14:19:51 INFO - PROCESS | 10309 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 14:19:51 INFO - PROCESS | 10309 | Values: 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 14:19:51 INFO - PROCESS | 10309 | 14:19:51 INFO - PROCESS | 10309 | [#8] json-parse-financial Cycles:10 Average:52.10 Median:52.00 stddev:1.52 (2.9%) stddev-sans-first:1.56 14:19:51 INFO - PROCESS | 10309 | Values: 51.0 51.0 52.0 52.0 53.0 52.0 51.0 51.0 52.0 56.0 14:19:51 INFO - PROCESS | 10309 | 14:19:51 INFO - PROCESS | 10309 | [#9] json-stringify-tinderbox Cycles:10 Average:60.10 Median:60.00 stddev:1.37 (2.3%) stddev-sans-first:1.39 14:19:51 INFO - PROCESS | 10309 | Values: 59.0 59.0 62.0 60.0 60.0 59.0 60.0 60.0 63.0 59.0 14:19:51 INFO - PROCESS | 10309 | 14:19:51 INFO - PROCESS | 10309 | [#10] stanford-crypto-aes Cycles:10 Average:75.60 Median:75.00 stddev:4.01 (5.3%) stddev-sans-first:3.74 14:19:51 INFO - PROCESS | 10309 | Values: 81.0 80.0 73.0 73.0 77.0 72.0 72.0 73.0 82.0 73.0 14:19:51 INFO - PROCESS | 10309 | 14:19:51 INFO - PROCESS | 10309 | [#11] stanford-crypto-ccm Cycles:10 Average:128.00 Median:124.50 stddev:14.90 (12.0%) stddev-sans-first:15.64 14:19:51 INFO - PROCESS | 10309 | Values: 122.0 118.0 137.0 119.0 123.0 126.0 129.0 118.0 167.0 121.0 14:19:51 INFO - PROCESS | 10309 | 14:19:51 INFO - PROCESS | 10309 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.10 Median:153.50 stddev:2.02 (1.3%) stddev-sans-first:2.03 14:19:51 INFO - PROCESS | 10309 | Values: 154.0 151.0 154.0 151.0 154.0 149.0 153.0 154.0 152.0 149.0 14:19:51 INFO - PROCESS | 10309 | 14:19:51 INFO - PROCESS | 10309 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.90 Median:62.00 stddev:3.25 (5.2%) stddev-sans-first:3.42 14:19:51 INFO - PROCESS | 10309 | Values: 63.0 61.0 63.0 63.0 70.0 60.0 59.0 61.0 60.0 59.0 14:19:51 INFO - PROCESS | 10309 | -------- Summary: end -------- 14:19:51 INFO - PROCESS | 10309 | 14:19:52 INFO - TEST-INFO | 10309: exit 0 14:19:52 INFO - TEST-OK | kraken | took 61898ms 14:19:52 INFO - SUITE-END | took 1173s 14:19:52 INFO - Completed test suite (00:19:33) 14:19:52 INFO - javascript benchmark 14:19:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7800.942259175404, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3169.540416639586, 3188.728958038567, 3205.727513161381, 3318.203631128529, 3321.7342612590987, 5766.798162064329, 5769.8269051928455, 5791.21818554495, 5838.766449342026, 5857.4435428634315, 5637.069883469223, 5809.0, 5812.128180772876, 5814.156947242647, 5836.824895253149, 5257.263983042368, 5314.3091398118195, 5324.787008519655, 5339.733013349336, 5377.381601115882, 5355.491228333302, 5360.812371566996, 5371.301730774994, 5375.43557926418, 5399.0, 5048.469910659383, 5076.822311219108, 5352.357717073956, 5360.061989151883, 5374.274472946141, 5188.8702782430555, 5202.921956170641, 5272.789088436496, 5349.7592608332325, 5378.542823859977, 5236.947630523722, 5297.17893726473, 5313.7608807603365, 5320.733963301858, 5345.0, 5602.215689803431, 5766.394528574523, 5775.5957083004205, 5837.562182836262, 5915.08316210988, 6121.265448146207, 6128.717018009216, 6142.6007309525185, 6234.0337247726675, 6247.2815626202655, 6273.404026617464, 6274.780382686584, 6275.780347687809, 6276.560640755149, 6278.78024269153, 5643.858903527444, 5867.823965281048, 5868.061110222344, 5879.32387775407, 5907.9704601476715, 6158.661273629993, 6189.752409903554, 6207.472364849038, 6302.369763023661, 6309.716062777186, 6015.879682406327, 6065.878682426415, 6068.696565171724, 6070.910139394308, 6118.20463339763, 6036.124761909498, 6091.786787462506, 6147.907781383283, 6159.076138579159, 6167.414095660905, 6101.725422356005, 6111.77406523465, 6136.417040381157, 6229.813105606839, 6244.625322480575, 6199.938000620026, 6201.348858369896, 6210.31686514483, 6212.47193988507, 6237.438630523184, 4592.931106033412, 4758.381410416624, 4765.213739732905, 4770.785314660849, 4781.784819683123, 4111.362738775495, 4124.443200167999, 4155.667546596265, 4157.438745769343, 4194.328907374806, 5931.139984702194, 5965.343812180657, 5972.283326000907, 5974.283086029617, 5976.103584462366, 5979.073243647242, 6233.812985610439, 6243.719032643542, 6248.0, 6254.9687251563455, 5866.794662186889, 5930.911036334458, 5937.168796368512, 5996.940030599725, 5999.580029397987, 5368.892622147535, 5377.0, 5383.973080134574, 5386.353637563518, 5388.649737767033, 6150.7847225346895, 6297.4017468340435, 6496.577722448026, 6499.05763664266, 6507.251666058464, 6165.136880836597, 6300.464460520724, 6309.990401535732, 6310.085037669604, 6315.621062736067, 6468.935310647022, 6525.477961762953, 6526.282108968105, 6530.118434011348, 6549.967250163719, 5877.235959325431, 5930.970345148246, 6148.200733904564, 6150.600210986271, 6174.413430724074, 6064.3935606439, 6117.063650123533, 6134.467201660849, 6134.957077261001, 6144.938550614436, 5969.940300596939, 5986.0, 5987.43119403656, 6000.849978750566, 6030.6080104793045, 5828.854278643068, 5854.736536855767, 5948.970255148696, 5951.285845698544, 5963.880722385615, 5977.671228082323, 6028.367021462858, 6094.421030002142, 6105.725242364193, 6108.5723999319625, 6065.575409721454, 6076.513878889767, 6121.755129794758, 6140.478059365004, 6158.784442544489, 5779.566532510163, 5981.342052374148, 6000.849978750566, 6016.548758843017, 6028.788992385421], "value": 5710.01905172417, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [591.0897218283841, 641.2657507154308, 663.8539521305314, 667.3726696904911, 692.4460431654675, 43013.0, 47548.2867756983, 47549.28676069862, 47650.76174619122, 47696.52303476964, 47071.29393059107, 47491.52508474923, 47495.52504474954, 47515.049699006, 47619.28571071428, 9100.226480749145, 9221.907780922173, 9240.722778316627, 9250.07499250073, 9258.166764991149, 9156.679516216935, 9232.0, 9246.26029917605, 9281.257499400032, 9282.164605185531, 9261.6295348186, 9324.62701491943, 9325.114114159143, 9336.953315233415, 9341.112594303564, 9191.540422978824, 9231.076892310783, 9273.258139348836, 9276.118768717028, 9285.210757085655, 9264.073592640749, 9333.300002499771, 9344.532773361372, 9354.532273386303, 9354.672586459441, 44693.55306446959, 44767.0, 44855.327170092474, 45026.0, 45169.096618067786, 3634.945475817865, 4069.877903662895, 4577.313402989545, 4615.14619795339, 4638.628909687217, 34422.10805600567, 35003.824980875186, 35157.82421087904, 35547.82226088879, 35548.28903421943, 4737.928931066037, 4745.454272758642, 4774.785134668913, 4789.592884604813, 4793.7363445010515, 361519.0, 361582.0, 362244.0, 362693.0, 363130.0, 64159.67920160369, 64755.0, 64833.0, 64863.67568162223, 64933.67533162304, 40371.59628403737, 40612.39081413781, 40777.98055048648, 43775.0, 68856.0, 15335.693286134216, 15348.0, 15467.303971321093, 15490.380384784483, 15492.380304787683, 11047.889521104686, 11094.5562177512, 11097.500612472459, 11102.000819926085, 11116.722081948015, 20981.0, 21269.68095478569, 21334.35996920095, 21400.35798926035, 21414.464638384165, 7526.661300241502, 7544.886826697604, 7659.234076592296, 7749.0, 7828.334591559667, 1025.564135242534, 1065.5151905882806, 1083.9620613278498, 1151.8214676724954, 1192.2131393280392, 34702.65297346994, 34735.652643473244, 35137.648623513436, 35254.82372588121, 35454.468182977274, 1095.0, 1148.0872706198593, 1154.520873837365, 1191.8951132300413, 1241.1436109084702, 17971.640567188584, 18560.814391855907, 18563.721544176577, 18565.535861603297, 18791.530211744543, 586412.0, 588012.0, 590960.0, 594016.0, 596707.0, 64135.35864641387, 64774.0, 64865.35134648593, 65123.67438162779, 65224.67387663126, 1427.4504315838476, 1462.4004158295047, 1470.0003997281738, 1470.2795630141154, 1477.8300495442948, 32576.0, 34137.31725365528, 34150.14624634404, 34663.65336346705, 35018.649813501535, 57016.0, 61082.69458652856, 63156.0, 63258.0, 67317.32682673307, 562851.0, 565002.0, 566298.0, 568663.0, 570913.0, 48894.51105488899, 49183.26225106555, 49459.25811112908, 49652.50347496479, 50246.748766255936, 53255.46744532505, 53849.0, 54076.0, 54174.72912635569, 54257.45742542682, 45857.0, 46465.767671161426, 47218.76390618025, 47485.287720683526, 47920.2811957814, 47333.52666473429, 47531.28703069388, 47551.52448475471, 47838.0, 48680.0, 39741.205175896896, 43786.78106609447, 44158.11683766243, 46389.07221855612, 46669.29996049994, 39859.80070099631, 41591.58408415877, 41767.0, 41775.0, 42060.0, 30891.382172355978, 30933.381332373676, 31266.0, 31462.0, 31678.524822127227], "value": 21931.9287118477, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [420.8842568293717, 422.6567848319791, 436.5132876842322, 441.2719013627515, 443.19559998602534, 19471.902640486795, 21081.894590527027, 21149.471263218427, 22094.558108837853, 22319.10723571059, 20017.799822001776, 20305.796942030574, 20412.69380959283, 20433.182672693074, 20574.897125514388, 5894.557908156884, 6107.7556897724035, 6129.111278864562, 6151.323354431009, 6167.044108163242, 6057.151998720183, 6070.908936365936, 6098.08528720691, 6115.87768244637, 6122.142899994004, 5832.329282132567, 5937.079752638348, 5987.4311940365815, 5992.310884248302, 6003.849903752397, 5930.703464826763, 5940.405959404068, 5965.135055416984, 5969.492593129546, 5982.790602328898, 5306.204069389584, 5320.866978325535, 5338.733063346817, 5359.517643412073, 5375.408705042442, 24643.260702178963, 25534.23397298084, 25668.10161644352, 25693.486130277477, 25694.87152564244, 2722.5916112583072, 2723.196656986194, 2751.3946931675, 3089.3666798306294, 3163.509656003323, 15768.76346854798, 16038.278277477542, 16050.197490125563, 16259.837401625951, 16426.342946282133, 2001.8798872067723, 2061.8762874227446, 2103.8632488888325, 2130.9573808523896, 2139.4865232344127, 86319.0, 87160.12839871584, 88609.0, 88725.55637221837, 90386.54806725924, 11479.827802582968, 11842.644720658394, 12227.0, 12791.104622676323, 12890.677733056562, 16964.982101073976, 16966.660666786596, 16975.405860794814, 16978.49064528066, 17002.23489942931, 8144.389170812213, 8236.876446853303, 8320.958395207985, 8356.415050946376, 8419.516242708292, 7755.689772409153, 7811.765647030485, 7814.452988290879, 7949.960250198712, 7970.880436793453, 7171.342269954412, 7193.89209161863, 7221.602811845294, 7272.163701174327, 7312.341889229889, 2068.214078650103, 2174.923877664274, 2179.1936983316273, 2197.3847322749334, 2204.74645415776, 947.9146876781123, 1037.419045334615, 1077.450500244865, 1111.288775183883, 1202.458893497912, 21414.78585214159, 21448.892755536435, 21487.247946321804, 21530.03114859835, 21558.784412155677, 1066.57337065173, 1076.5747529725716, 1090.6618948126106, 1102.079763397572, 1156.919015668895, 11268.830967535494, 11871.406429678482, 11924.642260732191, 12232.633021009384, 12239.388030598435, 538130.0, 544751.0, 546786.0, 548908.0, 549232.0, 104094.0, 104104.0, 107082.0, 107889.46055269674, 108360.0, 1021.065724861758, 1066.2056767707952, 1072.3351522056375, 1111.366521082991, 1118.0608289037248, 18631.161597728405, 19135.52161195981, 19161.90419047896, 19239.903800480908, 19357.0, 44829.55170448254, 45079.77460112678, 46177.76911115423, 46452.53547464482, 46549.0, 58171.0, 66006.66996664986, 66656.0, 67515.3248467509, 68030.3196968024, 8241.381896357918, 8461.576921154041, 8645.394822362374, 8796.120387961153, 9470.47912364799, 10265.0, 13602.523911663044, 14430.639234019234, 14510.419583216553, 14539.491117810825, 12901.483940642269, 12987.805182922453, 12991.220526768424, 13127.934360328138, 13183.14309569875, 11880.46537905779, 12026.75946481083, 12258.14193006481, 12497.812532812197, 12715.745685086431, 12308.753824923631, 12388.070894683115, 13156.868431315565, 13172.670683232996, 13227.537036203687, 8480.363972701949, 8609.65561377538, 8695.869561956702, 8726.956365218133, 8740.78148046304, 9688.806223875625, 11571.942140289244, 11592.420378980849, 13203.603891883258, 13241.867581324064], "value": 10137.925998960525, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1541.57606658169, 1546.3814474210315, 1759.9824001759978, 1840.6686796376664, 1868.6075924055947, 8418.074011858705, 9156.954215228914, 9247.352685312031, 9716.85424718629, 9741.830980282359, 9107.726768196948, 9425.764355891106, 9539.713808585737, 9549.23606111511, 9556.617735290598, 2440.536298103359, 2500.9124680636182, 2502.074232533956, 2507.2728908616477, 2508.548461276969, 2406.085687438771, 2455.656208130863, 2475.2945410557995, 2481.2928315430104, 2485.950280994379, 2426.7815896569305, 2441.5849305618, 2469.3085935937966, 2471.394508345458, 2478.938026549333, 2369.620860662286, 2381.4760752634393, 2383.2611890314056, 2387.271882075966, 2391.497785465054, 2314.837961342707, 2351.1888398502488, 2358.339664893815, 2360.822938279619, 2368.928932132039, 9614.75963100921, 9641.614335426575, 9679.370840895319, 9728.41629502225, 9728.951355243178, 5500.944990550083, 5504.091824848895, 5549.72251387429, 5549.833504994856, 5721.485066344049, 3532.6643968822923, 3575.7496975211748, 3607.749476944296, 3643.4352675335367, 3745.5879853216125, 1259.5969289827258, 1275.5649893869397, 1290.5031562848278, 1298.9415476303589, 1313.2514466753953, 13198.208107513485, 13301.53444629443, 13301.600951971457, 13307.0, 13318.400671969785, 4791.976040119846, 4846.466888642247, 5013.197888337849, 5028.591994241545, 5065.3161823153405, 11248.718782030352, 11307.547698092148, 11334.716632084264, 11391.0, 11400.144989125683, 5669.716514174274, 5695.345035320908, 5722.856928576819, 5726.599138060379, 5739.713014349266, 4702.36518070063, 5062.367204099488, 5160.277561141444, 5200.947990520122, 5227.555657769132, 4310.073334233155, 4335.436393268855, 4401.2517871961845, 4424.093060922503, 4534.79593418297, 1349.9932500337436, 1366.3441548056987, 1371.1704418826466, 1372.457879137735, 1417.0859795431888, 1042.7497400623795, 1051.1118105201092, 1079.6491140379408, 1083.4474418046852, 1086.4187659602233, 6239.220097487814, 6308.369163083747, 6455.7740479083, 6468.838279043061, 6596.0, 476.21900083862494, 480.7404001838968, 482.8020511590231, 492.33534728116757, 494.44128135206984, 4429.689921705514, 4443.844465443694, 4531.184386810406, 4558.544145585415, 4646.4191976003, 11363.488643011084, 11624.186306958432, 11642.0, 11706.414679266003, 11719.531218751325, 11594.6521604352, 11782.293062416282, 11831.290122592673, 11936.104792140624, 11962.581309654295, 8423.747287581382, 8723.956380218058, 8856.0, 8952.731418057469, 8962.73111806647, 6259.78090766821, 6427.967860160669, 6441.838954026187, 6506.869862602816, 6520.804375868732, 10465.319754215952, 10468.842967355344, 10500.894991049992, 10641.14870810318, 10664.84002739975, 10727.892721072689, 10749.086327661924, 10790.622328218475, 10798.298110622783, 10847.349159050482, 8537.103604121477, 8643.481391116553, 8701.695440659547, 8729.869051964099, 8770.824583508422, 9213.032631573587, 9273.443593384418, 9326.72019839406, 9337.253019758267, 9352.438853668802, 8148.348132149533, 8313.833723325379, 8418.36862235347, 8432.494050356752, 8513.063563008189, 8204.876926845982, 8247.175282471704, 8248.340132789242, 8309.252167304972, 8312.25189732927, 7452.925470745223, 7584.5070070445245, 7599.734009309647, 7599.88600171009, 7603.2776886195725, 5561.749721262634, 5622.578306626938, 5666.121751128417, 5720.656760594377, 5835.44563266489, 5524.558035357242, 5560.02699527573, 5602.215689803512, 5659.886802264014, 5690.9430905690415], "value": 4907.200684270576, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.26697103510213, 353.56158363629106, 353.73469897576825, 356.2358740501624, 360.37295106514654, 5691.402402747714, 5755.827325180251, 5814.796482123126, 5935.228420305354, 5937.604662904219, 5781.4507621775865, 5802.912956305659, 5805.970970145154, 5822.912656310159, 5851.239338885939, 4552.180607490651, 4586.266197408415, 4590.60979816716, 4590.816367345302, 4601.953980460203, 4490.595846373826, 4601.861944141664, 4612.746298953556, 4623.838165664202, 4636.652251081166, 4573.725576465406, 4580.198465268565, 4589.908201835978, 4599.701019433743, 4600.7929643166135, 4569.451665800125, 4574.529753932872, 4596.97701511492, 4612.86161415158, 4632.930506042412, 3764.3036038333, 3924.7448915820382, 3941.3496773032416, 4118.794060296973, 4121.649659778923, 5578.219049333096, 5602.803901863415, 5610.523105536035, 5669.546436285087, 5685.493344263773, 5152.68129341794, 5165.302684137631, 5179.19722443022, 5180.948190518122, 5184.481551844785, 5788.913166302509, 6019.969900150515, 6061.757529698807, 6071.939280607182, 6085.330613632497, 4355.499117601485, 4355.673324500675, 4364.956350436519, 4374.125174964988, 4375.190589740908, 6181.598196117238, 6338.58799178052, 6343.365663433666, 6375.330590288046, 6416.550841441101, 4405.0, 4416.646668266595, 4417.580329868657, 4431.180231657154, 4434.578715022068, 4512.120136573402, 4517.119161763425, 4524.502304746476, 4525.52481989393, 4550.7497087660495, 5106.821261255838, 5162.483751624807, 5207.843764687065, 5209.47905209476, 5216.556592689664, 5944.64332140073, 6037.335893051761, 6060.696965151725, 6084.391560843968, 6105.198966304951, 1543.1975372806078, 1561.625209949604, 1567.4357231396689, 1567.5062355358025, 1571.8035245594301, 979.3193730357476, 1009.1371877045168, 1015.4516561056946, 1015.5886865819355, 1017.5065093429681, 5174.922376164361, 5184.662996905189, 5217.321748172713, 5236.842894713165, 5294.629375943647, 5431.479185827974, 5511.5039646432015, 5514.61397702157, 5520.861978450491, 5580.218769372291, 5008.522485866678, 5163.638545301793, 5219.19102539107, 5223.7910483580235, 5240.6069544784295, 2925.7074292570574, 2947.675755666875, 2955.527115661484, 2960.0, 2964.733174014349, 5645.967451717378, 5694.06401823382, 5705.5720820938595, 5719.54151691316, 5765.221695071195, 5236.895262094737, 5493.285872836585, 5517.475839795213, 5531.585131115183, 5532.28080349552, 5637.661740295595, 5640.32316122068, 5673.0, 5742.856428589319, 5748.827535173951, 5114.974425127851, 5437.564994800327, 5465.426130256265, 5519.806806761905, 5565.55475561946, 5394.004218439202, 5399.730013499231, 5421.945780542144, 5424.891502169856, 5448.427915069019, 5605.0, 5678.84204002493, 5715.428457154251, 5744.281964754406, 5758.2514273144225, 3883.2815929053218, 4016.879493615196, 4026.2752704512295, 4041.777702226406, 4067.6983365323995, 5413.025655382069, 5474.452554744494, 5528.226048353154, 6110.7861224856915, 6325.652089135142, 6156.661383623944, 6165.753369865155, 6173.290071641819, 6178.455386153461, 6189.721462534287, 6065.7573697053385, 6146.907796382969, 6147.938520614736, 6193.411625895533, 6242.843928901813, 6110.694465276807, 6122.908156377747, 6138.600990935575, 6167.259928808572, 6168.167297414791, 6221.9377806221355, 6223.097650840693, 6251.218597675291, 6278.968605156945, 6288.559800814082, 5895.852603684943, 6021.668808215591, 6064.423879731418, 6074.3014553325165, 6117.877642447215], "value": 4475.736438767538, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [822.1531822223109, 841.9621117049733, 855.5294587976612, 873.7029410000598, 942.3262367407302, 16160.83839161608, 16384.590385240375, 16857.24142413591, 16924.746128808078, 17063.82936170638, 15133.924330378333, 15162.166080865549, 15199.6960060799, 15204.923975380108, 15217.54347369578, 867.0, 877.5085951866959, 889.915458031486, 900.9774755631096, 903.5075883643398, 886.7206829848609, 891.6121487153109, 893.8748575199477, 894.00318644711, 894.9105089491064, 928.5450129436562, 931.4644079654225, 932.2169377722712, 932.5943214701626, 933.6218831373304, 917.7751450894507, 919.9126083022102, 922.967696130639, 925.2181906289142, 926.2636204217663, 671.8253254153906, 674.7739507265072, 675.4731309578488, 676.4250387170865, 677.8305423644089, 16082.919585401998, 16150.111743854084, 16170.919145404316, 16195.352185912549, 16242.187890605423, 15345.923270383688, 15420.46028389001, 15430.228488575527, 15536.844631553653, 15728.685426291524, 13865.930670346685, 13878.722425551534, 13885.0, 13922.860771392257, 14230.928845355811, 4081.8367265309353, 4111.0, 4193.308104162809, 4198.202341555126, 4227.281362168439, 83895.5805220976, 87509.56245218797, 88157.11842881617, 88918.0, 90745.54627226821, 12223.694407639703, 12780.424880880382, 12894.161879477804, 12962.157459765085, 13012.934935325262, 22732.31803045911, 22821.429464263525, 22835.429114271945, 22943.770562294496, 22980.65529017066, 9345.841100710119, 9683.757906052264, 9684.181245591586, 9829.0, 9993.900060999442, 5106.131957567222, 5123.897522049613, 5155.38135423744, 5230.137027390438, 5338.546223570962, 3450.4996775467416, 3531.6291789362263, 3548.6983606393746, 3549.574051113883, 3690.1881586051027, 675.5811396933932, 686.7253098760535, 691.0360047733384, 691.4399336537421, 702.8699690557263, 739.6412739821183, 754.1515794730927, 758.893754874307, 762.6225018615821, 776.5263189454429, 10017.949910250401, 10508.632197873038, 10580.89419105799, 10659.786804264026, 10835.079018283377, 662.208660650518, 679.9558028728117, 706.6360824175554, 775.5269285735696, 776.5534817479971, 4687.343771871941, 4743.075100355398, 4969.428515720666, 5031.396232452129, 5152.3044389007755, 119358.0, 121857.0, 122290.3885480567, 123822.38088809678, 127119.36440317739, 104174.25395782947, 106250.0, 106855.0, 109131.0, 111205.0, 58617.41382586205, 59655.40344596585, 78520.60739696264, 91931.0, 94299.52850235841, 10373.740656483647, 10576.576936922436, 10607.840882386925, 10641.627543035956, 10663.4135122569, 54667.72666136644, 54764.726176368866, 55212.171817421964, 55328.44671553233, 56239.0, 76226.0, 83570.0, 83943.58028210064, 85075.5746221265, 86113.56943215244, 12592.244465332109, 12776.297303648389, 13209.669758255735, 13295.0, 13437.059405841497, 14349.85650143527, 14645.560633181021, 14748.852511474748, 14818.925905370405, 14931.92534037323, 13483.932580337036, 13725.519606813714, 13819.0, 13929.30353482342, 14641.780373294196, 14058.859411405754, 14204.928975355057, 14426.42294308216, 14614.926925365306, 14702.705945881236, 13552.457901683822, 13692.863071369158, 14698.265086745834, 14739.336729846968, 14761.0, 11022.944885275843, 11036.724081898017, 11719.765604687687, 11759.941200293944, 11781.0, 10589.470526473491, 10638.680839574825, 11748.29510229389, 11787.528498859949, 12120.333381664093], "value": 8081.214335136635, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1499.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 112.0, 105.0, 110.0, 111.0, 112.0, 111.0, 111.0, 111.0, 112.0], "value": 109.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 124.0, 145.0, 170.0, 116.0, 147.0, 140.0, 123.0, 168.0, 120.0], "value": 139.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 162.0, 164.0, 162.0, 162.0, 161.0, 161.0, 162.0, 161.0], "value": 161.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 76.0, 175.0, 77.0, 76.0, 75.0, 78.0, 182.0, 74.0], "value": 96.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 154.0, 83.0, 83.0, 82.0, 151.0, 83.0, 83.0, 144.0], "value": 103.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 148.0, 147.0, 148.0, 148.0, 146.0, 146.0, 148.0, 148.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 52.0, 52.0, 53.0, 52.0, 51.0, 51.0, 52.0, 56.0], "value": 52.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 62.0, 60.0, 60.0, 59.0, 60.0, 60.0, 63.0, 59.0], "value": 60.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 73.0, 73.0, 77.0, 72.0, 72.0, 73.0, 82.0, 73.0], "value": 75.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 118.0, 137.0, 119.0, 123.0, 126.0, 129.0, 118.0, 167.0, 121.0], "value": 128.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 151.0, 154.0, 151.0, 154.0, 149.0, 153.0, 154.0, 152.0, 149.0], "value": 152.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 61.0, 63.0, 63.0, 70.0, 60.0, 59.0, 61.0, 60.0, 59.0], "value": 61.9, "unit": "score"}]}]} 14:19:52 INFO - Return code: 0 14:19:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:19:52 ERROR - # TBPL SUCCESS # 14:19:52 INFO - Running post-action listener: _resource_record_post_action 14:19:52 INFO - [mozharness: 2016-10-27 21:19:52.386222Z] Finished run-tests step (success) 14:19:52 INFO - Running post-run listener: _resource_record_post_run 14:19:52 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 12288; Write bytes: 286224384; Read time: 328; Write time: 288084 14:19:52 INFO - TinderboxPrint: CPU usage
13.3% 14:19:52 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 328 14:19:52 INFO - TinderboxPrint: I/O write bytes / time
286,224,384 / 288,084 14:19:52 INFO - TinderboxPrint: CPU idle
8,222.0 (86.7%) 14:19:52 INFO - TinderboxPrint: CPU user
1,200.2 (12.7%) 14:19:52 INFO - TinderboxPrint: Swap in / out
0 / 0 14:19:52 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 4096; Write bytes: 70119424; Read time: 44; Write time: 121064 14:19:52 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 8192; Write bytes: 216104960; Read time: 284; Write time: 167020 14:19:53 INFO - Running post-run listener: _upload_blobber_files 14:19:53 INFO - Blob upload gear active. 14:19:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:19:53 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 14:19:53 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'] 14:19:53 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 14:19:53 INFO - (blobuploader) - INFO - Open directory for files ... 14:19:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:19:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:19:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:19:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:19:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:19:54 INFO - (blobuploader) - INFO - Done attempting. 14:19:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:19:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:19:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:19:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:19:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:19:54 INFO - (blobuploader) - INFO - Done attempting. 14:19:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:19:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:19:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:20:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:20:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:20:00 INFO - (blobuploader) - INFO - Done attempting. 14:20:00 INFO - (blobuploader) - INFO - Iteration through files over. 14:20:00 INFO - Return code: 0 14:20:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:20:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:20:00 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cf5a2abd6efe037f5f380c840f342459c083f45c94aea8d1d9795a8b4c2747c84eb84681aec6073a901daf01f40bb0fcdb1cf7b4ecd324dbb245ffe47efbbf40", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7c279ed02411e3be276bdc6ad459e1426a6ed2269ac95c824e50687208870354cac82c8a0ee6897d66fcfdbca1c9494a6752137280910ee727abf155499fb51f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/dc7d28d842ecdc6df61cc543008e11f07c6006f6bdef1d151db90fd4387c85b96f2f2711a59b547c844b5c8020565d600a999f1060ba3f70a3a28202850750d9"} 14:20:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:20:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:20:00 INFO - Contents: 14:20:00 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cf5a2abd6efe037f5f380c840f342459c083f45c94aea8d1d9795a8b4c2747c84eb84681aec6073a901daf01f40bb0fcdb1cf7b4ecd324dbb245ffe47efbbf40", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7c279ed02411e3be276bdc6ad459e1426a6ed2269ac95c824e50687208870354cac82c8a0ee6897d66fcfdbca1c9494a6752137280910ee727abf155499fb51f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/dc7d28d842ecdc6df61cc543008e11f07c6006f6bdef1d151db90fd4387c85b96f2f2711a59b547c844b5c8020565d600a999f1060ba3f70a3a28202850750d9"} 14:20:00 INFO - Running post-run listener: copy_logs_to_upload_dir 14:20:00 INFO - Copying logs to upload dir... 14:20:00 INFO - mkdir: /builds/slave/test/build/upload/logs 14:20:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1677.119197 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 57 secs) (at 2016-10-27 14:20:00.275575) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-27 14:20:00.279063) ========= 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=5cf47e208febbcd81da23b2e0000026f-1477601520.353984-1583879947 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/cf5a2abd6efe037f5f380c840f342459c083f45c94aea8d1d9795a8b4c2747c84eb84681aec6073a901daf01f40bb0fcdb1cf7b4ecd324dbb245ffe47efbbf40", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7c279ed02411e3be276bdc6ad459e1426a6ed2269ac95c824e50687208870354cac82c8a0ee6897d66fcfdbca1c9494a6752137280910ee727abf155499fb51f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/dc7d28d842ecdc6df61cc543008e11f07c6006f6bdef1d151db90fd4387c85b96f2f2711a59b547c844b5c8020565d600a999f1060ba3f70a3a28202850750d9"} build_url:https://queue.taskcluster.net/v1/task/NyUhgzcFQOORyptSJ-OXQg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011163 build_url: 'https://queue.taskcluster.net/v1/task/NyUhgzcFQOORyptSJ-OXQg/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/cf5a2abd6efe037f5f380c840f342459c083f45c94aea8d1d9795a8b4c2747c84eb84681aec6073a901daf01f40bb0fcdb1cf7b4ecd324dbb245ffe47efbbf40", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7c279ed02411e3be276bdc6ad459e1426a6ed2269ac95c824e50687208870354cac82c8a0ee6897d66fcfdbca1c9494a6752137280910ee727abf155499fb51f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/dc7d28d842ecdc6df61cc543008e11f07c6006f6bdef1d151db90fd4387c85b96f2f2711a59b547c844b5c8020565d600a999f1060ba3f70a3a28202850750d9"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-27 14:20:00.314863) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 14:20:00.315271) ========= 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=5cf47e208febbcd81da23b2e0000026f-1477601520.353984-1583879947 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004397 ========= master_lag: 0.14 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 14:20:00.456728) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-27 14:20:00.457068) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-27 14:20:00.457410) ========= ========= Total master_lag: 0.25 =========