builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-049 starttime: 1476140971.72 results: success (0) buildid: 20161010141524 builduid: c71f1dfc3784477e8459035bbe50a980 revision: 0c41036b9e63facf1beb52b8ced744d525ca77d1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-10 16:09:31.722795) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-10 16:09:31.723454) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-10 16:09:31.723820) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-10 16:09:31.739149) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 16:09:31.739578) ========= 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=db7e7c15f3ca076d53731445000001ba-1476140971.709362-1299813503 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-10 16:09:32-- 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% 228M=0s 2016-10-10 16:09:32 (228 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.091221 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 16:09:31.844933) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 16:09:31.845332) ========= 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=db7e7c15f3ca076d53731445000001ba-1476140971.709362-1299813503 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020903 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 16:09:31.896234) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 16:09:31.896650) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 0c41036b9e63facf1beb52b8ced744d525ca77d1 --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 0c41036b9e63facf1beb52b8ced744d525ca77d1 --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=db7e7c15f3ca076d53731445000001ba-1476140971.709362-1299813503 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-10 16:09:32,846 truncating revision to first 12 chars 2016-10-10 16:09:32,846 Setting DEBUG logging. 2016-10-10 16:09:32,846 attempt 1/10 2016-10-10 16:09:32,846 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/0c41036b9e63?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-10 16:09:33,177 unpacking tar archive at: mozilla-beta-0c41036b9e63/testing/mozharness/ program finished with exit code 0 elapsedTime=0.702022 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 16:09:32.612681) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-10 16:09:32.613039) ========= script_repo_revision: 0c41036b9e63facf1beb52b8ced744d525ca77d1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-10 16:09:32.613462) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-10 16:09:32.613757) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-10 16:09:32.622963) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 53 secs) (at 2016-10-10 16:09:32.623363) ========= /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=db7e7c15f3ca076d53731445000001ba-1476140971.709362-1299813503 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:09:33 INFO - MultiFileLogger online at 20161010 16:09:33 in /builds/slave/test 16:09:33 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 16:09:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:09:33 INFO - {'append_to_log': False, 16:09:33 INFO - 'base_work_dir': '/builds/slave/test', 16:09:33 INFO - 'blob_upload_branch': 'Mozilla-Beta', 16:09:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:09:33 INFO - 'branch': 'Mozilla-Beta', 16:09:33 INFO - 'buildbot_json_path': 'buildprops.json', 16:09:33 INFO - 'config_files': ('talos/linux_config.py',), 16:09:33 INFO - 'default_actions': ('clobber', 16:09:33 INFO - 'read-buildbot-config', 16:09:33 INFO - 'download-and-extract', 16:09:33 INFO - 'populate-webroot', 16:09:33 INFO - 'create-virtualenv', 16:09:33 INFO - 'install', 16:09:33 INFO - 'run-tests'), 16:09:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:09:33 INFO - 'download_minidump_stackwalk': True, 16:09:33 INFO - 'download_symbols': 'ondemand', 16:09:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:09:33 INFO - 'tooltool.py': '/tools/tooltool.py', 16:09:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:09:33 INFO - '/tools/misc-python/virtualenv.py')}, 16:09:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:09:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:09:33 INFO - 'installer_path': 'installer.exe', 16:09:33 INFO - 'log_level': 'info', 16:09:33 INFO - 'log_name': 'talos', 16:09:33 INFO - 'log_to_console': True, 16:09:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:09:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:09:33 INFO - 'opt_config_files': (), 16:09:33 INFO - 'pip_index': False, 16:09:33 INFO - 'sps_profile': False, 16:09:33 INFO - 'sps_profile_interval': 0, 16:09:33 INFO - 'suite': 'dromaeojs-e10s', 16:09:33 INFO - 'system_bits': '32', 16:09:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:09:33 INFO - 'title': 'talos-linux64-ix-049', 16:09:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:09:33 INFO - 'use_talos_json': True, 16:09:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:09:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:09:33 INFO - 'work_dir': 'build'} 16:09:33 INFO - [mozharness: 2016-10-10 23:09:33.664493Z] Running clobber step. 16:09:33 INFO - Running pre-action listener: _resource_record_pre_action 16:09:33 INFO - Running main action method: clobber 16:09:33 INFO - rmtree: /builds/slave/test/build 16:09:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:09:34 INFO - Running post-action listener: _resource_record_post_action 16:09:34 INFO - [mozharness: 2016-10-10 23:09:34.638388Z] Finished clobber step (success) 16:09:34 INFO - [mozharness: 2016-10-10 23:09:34.638488Z] Running read-buildbot-config step. 16:09:34 INFO - Running pre-action listener: _resource_record_pre_action 16:09:34 INFO - Running main action method: read_buildbot_config 16:09:34 INFO - Using buildbot properties: 16:09:34 INFO - { 16:09:34 INFO - "project": "", 16:09:34 INFO - "product": "firefox", 16:09:34 INFO - "script_repo_revision": "production", 16:09:34 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 16:09:34 INFO - "repository": "", 16:09:34 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 16:09:34 INFO - "buildid": "20161010141524", 16:09:34 INFO - "pgo_build": "True", 16:09:34 INFO - "basedir": "/builds/slave/test", 16:09:34 INFO - "buildnumber": 278, 16:09:34 INFO - "slavename": "talos-linux64-ix-049", 16:09:34 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 16:09:34 INFO - "platform": "ubuntu64_hw", 16:09:34 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 16:09:34 INFO - "branch": "mozilla-beta", 16:09:34 INFO - "repo_path": "releases/mozilla-beta", 16:09:34 INFO - "revision": "0c41036b9e63facf1beb52b8ced744d525ca77d1", 16:09:34 INFO - "stage_platform": "linux64-pgo", 16:09:34 INFO - "builduid": "c71f1dfc3784477e8459035bbe50a980", 16:09:34 INFO - "slavebuilddir": "test" 16:09:34 INFO - } 16:09:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/NcIysMkiS16GTAPmO-Y0Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2. 16:09:34 INFO - Running post-action listener: _resource_record_post_action 16:09:34 INFO - [mozharness: 2016-10-10 23:09:34.640948Z] Finished read-buildbot-config step (success) 16:09:34 INFO - [mozharness: 2016-10-10 23:09:34.641038Z] Running download-and-extract step. 16:09:34 INFO - Running pre-action listener: _resource_record_pre_action 16:09:34 INFO - Running main action method: download_and_extract 16:09:34 INFO - mkdir: /builds/slave/test/build/tests 16:09: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')]} 16:09:34 INFO - https://queue.taskcluster.net/v1/task/NcIysMkiS16GTAPmO-Y0Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 16:09:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NcIysMkiS16GTAPmO-Y0Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 16:09:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NcIysMkiS16GTAPmO-Y0Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 16:09:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NcIysMkiS16GTAPmO-Y0Og/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 16:09:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NcIysMkiS16GTAPmO-Y0Og/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 16:09:34 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NcIysMkiS16GTAPmO-Y0Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 16:09:34 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 16:09:34 INFO - retry: Failed, sleeping 30 seconds before retrying 16:10:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NcIysMkiS16GTAPmO-Y0Og/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 16:10:04 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NcIysMkiS16GTAPmO-Y0Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 16:10:04 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 16:10:04 INFO - retry: Failed, sleeping 60 seconds before retrying 16:11:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NcIysMkiS16GTAPmO-Y0Og/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 16:11:04 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NcIysMkiS16GTAPmO-Y0Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 16:11:04 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 16:11:04 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NcIysMkiS16GTAPmO-Y0Og/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! 16:11:04 INFO - Caught exception: HTTP Error 404: Not Found 16:11:04 INFO - Caught exception: HTTP Error 404: Not Found 16:11:04 INFO - Caught exception: HTTP Error 404: Not Found 16:11:04 INFO - trying https://queue.taskcluster.net/v1/task/NcIysMkiS16GTAPmO-Y0Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 16:11:04 INFO - Downloading https://queue.taskcluster.net/v1/task/NcIysMkiS16GTAPmO-Y0Og/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 16:11:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NcIysMkiS16GTAPmO-Y0Og/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 16:11:05 INFO - Downloaded 1327 bytes. 16:11:05 INFO - Reading from file /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 16:11:05 INFO - Using the following test package requirements: 16:11:05 INFO - {u'common': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'], 16:11:05 INFO - u'cppunittest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 16:11:05 INFO - u'firefox-50.0.en-US.linux-x86_64.cppunittest.tests.zip'], 16:11:05 INFO - u'gtest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 16:11:05 INFO - u'firefox-50.0.en-US.linux-x86_64.gtest.tests.zip'], 16:11:05 INFO - u'jittest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 16:11:05 INFO - u'jsshell-linux-x86_64.zip'], 16:11:05 INFO - u'mochitest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 16:11:05 INFO - u'firefox-50.0.en-US.linux-x86_64.mochitest.tests.zip'], 16:11:05 INFO - u'mozbase': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'], 16:11:05 INFO - u'reftest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 16:11:05 INFO - u'firefox-50.0.en-US.linux-x86_64.reftest.tests.zip'], 16:11:05 INFO - u'talos': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 16:11:05 INFO - u'firefox-50.0.en-US.linux-x86_64.talos.tests.zip'], 16:11:05 INFO - u'web-platform': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 16:11:05 INFO - u'firefox-50.0.en-US.linux-x86_64.web-platform.tests.zip'], 16:11:05 INFO - u'xpcshell': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 16:11:05 INFO - u'firefox-50.0.en-US.linux-x86_64.xpcshell.tests.zip']} 16:11:05 INFO - Downloading packages: [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:11:05 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')]} 16:11:05 INFO - https://queue.taskcluster.net/v1/task/NcIysMkiS16GTAPmO-Y0Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:11:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NcIysMkiS16GTAPmO-Y0Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 16:11:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NcIysMkiS16GTAPmO-Y0Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 16:11:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NcIysMkiS16GTAPmO-Y0Og/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 16:11:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NcIysMkiS16GTAPmO-Y0Og/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 16:11:05 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NcIysMkiS16GTAPmO-Y0Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 16:11:05 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 16:11:05 INFO - retry: Failed, sleeping 30 seconds before retrying 16:11:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NcIysMkiS16GTAPmO-Y0Og/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 16:11:35 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NcIysMkiS16GTAPmO-Y0Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 16:11:35 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 16:11:35 INFO - retry: Failed, sleeping 60 seconds before retrying 16:12:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NcIysMkiS16GTAPmO-Y0Og/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 16:12:35 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NcIysMkiS16GTAPmO-Y0Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 16:12:35 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 16:12:35 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NcIysMkiS16GTAPmO-Y0Og/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! 16:12:35 INFO - Caught exception: HTTP Error 404: Not Found 16:12:35 INFO - Caught exception: HTTP Error 404: Not Found 16:12:35 INFO - Caught exception: HTTP Error 404: Not Found 16:12:35 INFO - trying https://queue.taskcluster.net/v1/task/NcIysMkiS16GTAPmO-Y0Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 16:12:35 INFO - Downloading https://queue.taskcluster.net/v1/task/NcIysMkiS16GTAPmO-Y0Og/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 16:12:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NcIysMkiS16GTAPmO-Y0Og/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 16:12:36 INFO - Downloaded 21774306 bytes. 16:12:36 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'] 16:12:36 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 16:12:37 INFO - Return code: 0 16:12:37 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 16:12:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:12:37 INFO - https://queue.taskcluster.net/v1/task/NcIysMkiS16GTAPmO-Y0Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:12:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NcIysMkiS16GTAPmO-Y0Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 16:12:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NcIysMkiS16GTAPmO-Y0Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 16:12:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NcIysMkiS16GTAPmO-Y0Og/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 16:12:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NcIysMkiS16GTAPmO-Y0Og/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 16:12:37 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NcIysMkiS16GTAPmO-Y0Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 16:12:37 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 16:12:37 INFO - retry: Failed, sleeping 30 seconds before retrying 16:13:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NcIysMkiS16GTAPmO-Y0Og/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 16:13:07 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NcIysMkiS16GTAPmO-Y0Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 16:13:07 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 16:13:07 INFO - retry: Failed, sleeping 60 seconds before retrying 16:14:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NcIysMkiS16GTAPmO-Y0Og/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 16:14:07 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NcIysMkiS16GTAPmO-Y0Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 16:14:07 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 16:14:07 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NcIysMkiS16GTAPmO-Y0Og/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! 16:14:07 INFO - Caught exception: HTTP Error 404: Not Found 16:14:07 INFO - Caught exception: HTTP Error 404: Not Found 16:14:07 INFO - Caught exception: HTTP Error 404: Not Found 16:14:07 INFO - trying https://queue.taskcluster.net/v1/task/NcIysMkiS16GTAPmO-Y0Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 16:14:07 INFO - Downloading https://queue.taskcluster.net/v1/task/NcIysMkiS16GTAPmO-Y0Og/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 16:14:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NcIysMkiS16GTAPmO-Y0Og/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 16:14:08 INFO - Downloaded 21774306 bytes. 16:14:08 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:14:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 16:14:09 INFO - Return code: 0 16:14:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:14:09 INFO - https://queue.taskcluster.net/v1/task/NcIysMkiS16GTAPmO-Y0Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:14:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NcIysMkiS16GTAPmO-Y0Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 16:14:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NcIysMkiS16GTAPmO-Y0Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 16:14:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NcIysMkiS16GTAPmO-Y0Og/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 16:14:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NcIysMkiS16GTAPmO-Y0Og/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 16:14:09 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NcIysMkiS16GTAPmO-Y0Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 16:14:09 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 16:14:09 INFO - retry: Failed, sleeping 30 seconds before retrying 16:14:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NcIysMkiS16GTAPmO-Y0Og/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 16:14:39 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NcIysMkiS16GTAPmO-Y0Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 16:14:39 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 16:14:39 INFO - retry: Failed, sleeping 60 seconds before retrying 16:15:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NcIysMkiS16GTAPmO-Y0Og/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 16:15:39 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NcIysMkiS16GTAPmO-Y0Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 16:15:39 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 16:15:39 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NcIysMkiS16GTAPmO-Y0Og/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! 16:15:39 INFO - Caught exception: HTTP Error 404: Not Found 16:15:39 INFO - Caught exception: HTTP Error 404: Not Found 16:15:39 INFO - Caught exception: HTTP Error 404: Not Found 16:15:39 INFO - trying https://queue.taskcluster.net/v1/task/NcIysMkiS16GTAPmO-Y0Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 16:15:39 INFO - Downloading https://queue.taskcluster.net/v1/task/NcIysMkiS16GTAPmO-Y0Og/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 16:15:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NcIysMkiS16GTAPmO-Y0Og/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 16:15:40 INFO - Downloaded 14413740 bytes. 16:15:40 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'] 16:15:40 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 16:15:40 INFO - Return code: 0 16:15:40 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')]} 16:15:40 INFO - https://queue.taskcluster.net/v1/task/NcIysMkiS16GTAPmO-Y0Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:15:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NcIysMkiS16GTAPmO-Y0Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 16:15:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NcIysMkiS16GTAPmO-Y0Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 16:15:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NcIysMkiS16GTAPmO-Y0Og/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 16:15:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NcIysMkiS16GTAPmO-Y0Og/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 16:15:40 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NcIysMkiS16GTAPmO-Y0Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 16:15:40 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 16:15:40 INFO - retry: Failed, sleeping 30 seconds before retrying 16:16:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NcIysMkiS16GTAPmO-Y0Og/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 16:16:10 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NcIysMkiS16GTAPmO-Y0Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 16:16:10 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 16:16:10 INFO - retry: Failed, sleeping 60 seconds before retrying 16:17:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NcIysMkiS16GTAPmO-Y0Og/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 16:17:10 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NcIysMkiS16GTAPmO-Y0Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 16:17:10 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 16:17:10 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NcIysMkiS16GTAPmO-Y0Og/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! 16:17:10 INFO - Caught exception: HTTP Error 404: Not Found 16:17:10 INFO - Caught exception: HTTP Error 404: Not Found 16:17:10 INFO - Caught exception: HTTP Error 404: Not Found 16:17:10 INFO - trying https://queue.taskcluster.net/v1/task/NcIysMkiS16GTAPmO-Y0Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 16:17:10 INFO - Downloading https://queue.taskcluster.net/v1/task/NcIysMkiS16GTAPmO-Y0Og/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 16:17:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NcIysMkiS16GTAPmO-Y0Og/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 16:17:12 INFO - Downloaded 56803467 bytes. 16:17:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NcIysMkiS16GTAPmO-Y0Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 16:17:12 INFO - mkdir: /builds/slave/test/properties 16:17:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:17:12 INFO - Writing to file /builds/slave/test/properties/build_url 16:17:12 INFO - Contents: 16:17:12 INFO - build_url:https://queue.taskcluster.net/v1/task/NcIysMkiS16GTAPmO-Y0Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 16:17:12 INFO - Running post-action listener: _resource_record_post_action 16:17:12 INFO - Running post-action listener: set_extra_try_arguments 16:17:12 INFO - [mozharness: 2016-10-10 23:17:12.859442Z] Finished download-and-extract step (success) 16:17:12 INFO - [mozharness: 2016-10-10 23:17:12.859676Z] Running populate-webroot step. 16:17:12 INFO - Running pre-action listener: _resource_record_pre_action 16:17:12 INFO - Running main action method: populate_webroot 16:17:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:17:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:17:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:17:12 INFO - '--tppagecycles', 16:17:12 INFO - '7'], 16:17:12 INFO - 'tests': ['tsvgm']}}, 16:17:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:17:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:17:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:17:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:17:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:17:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:17:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:17:12 INFO - 'talos_options': ['--disable-e10s'], 16:17:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:17:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:17:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:17:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:17:12 INFO - 'talos_options': ['--disable-e10s'], 16:17:12 INFO - 'tests': ['damp', 'tps']}, 16:17:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:17:12 INFO - 'tests': ['damp', 'tps']}, 16:17:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:17:12 INFO - 'tests': ['dromaeo_dom']}, 16:17:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:17:12 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:17:12 INFO - 'tests': ['basic_compositor_video']}, 16:17:12 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:17:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:17:12 INFO - 'tests': ['a11yr', 16:17:12 INFO - 'ts_paint', 16:17:12 INFO - 'tpaint', 16:17:12 INFO - 'sessionrestore', 16:17:12 INFO - 'sessionrestore_no_auto_restore', 16:17:12 INFO - 'tabpaint']}, 16:17:12 INFO - 'other-e10s': {'tests': ['a11yr', 16:17:12 INFO - 'ts_paint', 16:17:12 INFO - 'tpaint', 16:17:12 INFO - 'sessionrestore', 16:17:12 INFO - 'sessionrestore_no_auto_restore', 16:17:12 INFO - 'tabpaint']}, 16:17:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:17:12 INFO - 'ts_paint', 16:17:12 INFO - 'tpaint', 16:17:12 INFO - 'sessionrestore', 16:17:12 INFO - 'sessionrestore_no_auto_restore', 16:17:12 INFO - 'tabpaint']}, 16:17:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:17:12 INFO - 'ts_paint', 16:17:12 INFO - 'tpaint', 16:17:12 INFO - 'sessionrestore', 16:17:12 INFO - 'sessionrestore_no_auto_restore', 16:17:12 INFO - 'tabpaint']}, 16:17:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:17:12 INFO - 'tests': ['a11yr', 16:17:12 INFO - 'ts_paint', 16:17:12 INFO - 'tpaint', 16:17:12 INFO - 'sessionrestore', 16:17:12 INFO - 'sessionrestore_no_auto_restore', 16:17:12 INFO - 'tabpaint']}, 16:17:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:17:12 INFO - 'tests': ['a11yr', 16:17:12 INFO - 'ts_paint', 16:17:12 INFO - 'tpaint', 16:17:12 INFO - 'sessionrestore', 16:17:12 INFO - 'sessionrestore_no_auto_restore', 16:17:12 INFO - 'tabpaint']}, 16:17:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:17:12 INFO - 'tests': ['tsvgx', 16:17:12 INFO - 'tsvgr_opacity', 16:17:12 INFO - 'tart', 16:17:12 INFO - 'tscrollx', 16:17:12 INFO - 'cart']}, 16:17:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:17:12 INFO - 'tsvgr_opacity', 16:17:12 INFO - 'tart', 16:17:12 INFO - 'tscrollx', 16:17:12 INFO - 'cart']}, 16:17:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:17:12 INFO - 'talos_options': ['--disable-e10s'], 16:17:12 INFO - 'tests': ['tp5o']}, 16:17:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:17:12 INFO - 'tests': ['tp5o']}, 16:17:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:17:12 INFO - 'talos_options': ['--disable-e10s', 16:17:12 INFO - '--xperf_path', 16:17:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:17:12 INFO - 'tests': ['tp5n']}, 16:17:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:17:12 INFO - 'talos_options': ['--xperf_path', 16:17:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:17:12 INFO - 'tests': ['tp5n']}}, 16:17:12 INFO - 'talos.zip': {'path': '', 16:17:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:17:12 INFO - Running post-action listener: _resource_record_post_action 16:17:12 INFO - [mozharness: 2016-10-10 23:17:12.877816Z] Finished populate-webroot step (success) 16:17:12 INFO - [mozharness: 2016-10-10 23:17:12.877905Z] Running create-virtualenv step. 16:17:12 INFO - Running pre-action listener: _resource_record_pre_action 16:17:12 INFO - Running main action method: create_virtualenv 16:17:12 INFO - Creating virtualenv /builds/slave/test/build/venv 16:17:12 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 16:17:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:17:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:17:12 INFO - Using real prefix '/usr' 16:17:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:17:13 INFO - Installing distribute.............................................................................................................................................................................................done. 16:17:15 INFO - Installing pip.................done. 16:17:15 INFO - Return code: 0 16:17:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:17:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:17:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:17:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:17:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:17:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:17:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:17:15 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 0x1bb9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d1c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1de8400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e77570>, '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 0x1e78470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e78900>, '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': 'db7e7c15f3ca076d53731445000001ba-1476140971.709362-1299813503', '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 16:17:15 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 16:17:15 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 16:17:15 INFO - Using env: {'DISPLAY': ':0', 16:17:15 INFO - 'HOME': '/home/cltbld', 16:17:15 INFO - 'LANG': 'en_US.UTF-8', 16:17:15 INFO - 'LANGUAGE': 'en_US:en', 16:17:15 INFO - 'LOGNAME': 'cltbld', 16:17:15 INFO - 'MAIL': '/var/mail/cltbld', 16:17:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:17:15 INFO - 'MOZ_NO_REMOTE': '1', 16:17:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:17:15 INFO - 'NO_EM_RESTART': '1', 16:17:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:17:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:17:15 INFO - 'PWD': '/builds/slave/test', 16:17:15 INFO - 'SHELL': '/bin/bash', 16:17:15 INFO - 'SHLVL': '1', 16:17:15 INFO - 'TERM': 'linux', 16:17:15 INFO - 'TMOUT': '86400', 16:17:15 INFO - 'USER': 'cltbld', 16:17:15 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1476140971.709362-1299813503', 16:17:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:17:15 INFO - '_': '/tools/buildbot/bin/python'} 16:17:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:17:15 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 16:17:15 INFO - Cleaning up... 16:17:15 INFO - Return code: 0 16:17:15 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:17:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:17:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:17:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:17:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:17:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:17:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:17:15 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 0x1bb9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d1c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1de8400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e77570>, '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 0x1e78470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e78900>, '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': 'db7e7c15f3ca076d53731445000001ba-1476140971.709362-1299813503', '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 16:17:15 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 16:17:15 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 16:17:15 INFO - Using env: {'DISPLAY': ':0', 16:17:15 INFO - 'HOME': '/home/cltbld', 16:17:15 INFO - 'LANG': 'en_US.UTF-8', 16:17:15 INFO - 'LANGUAGE': 'en_US:en', 16:17:15 INFO - 'LOGNAME': 'cltbld', 16:17:15 INFO - 'MAIL': '/var/mail/cltbld', 16:17:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:17:15 INFO - 'MOZ_NO_REMOTE': '1', 16:17:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:17:15 INFO - 'NO_EM_RESTART': '1', 16:17:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:17:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:17:15 INFO - 'PWD': '/builds/slave/test', 16:17:15 INFO - 'SHELL': '/bin/bash', 16:17:15 INFO - 'SHLVL': '1', 16:17:15 INFO - 'TERM': 'linux', 16:17:15 INFO - 'TMOUT': '86400', 16:17:15 INFO - 'USER': 'cltbld', 16:17:15 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1476140971.709362-1299813503', 16:17:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:17:15 INFO - '_': '/tools/buildbot/bin/python'} 16:17:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:17:15 INFO - Downloading/unpacking psutil>=3.1.1 16:17:15 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 16:17:15 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 16:17:15 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 16:17:15 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 16:17:15 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 16:17:15 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 16:17:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:17:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:17:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:17:17 INFO - Installing collected packages: psutil 16:17:17 INFO - Running setup.py install for psutil 16:17:17 INFO - building 'psutil._psutil_linux' extension 16:17:17 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 16:17:18 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 16:17:18 INFO - building 'psutil._psutil_posix' extension 16:17:18 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 16:17:18 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 16:17:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:17:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:17:18 INFO - Successfully installed psutil 16:17:18 INFO - Cleaning up... 16:17:18 INFO - Return code: 0 16:17:18 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:17: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')]} 16:17:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:17:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:17: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')]} 16:17:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:17:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:17:18 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 0x1bb9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d1c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1de8400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e77570>, '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 0x1e78470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e78900>, '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': 'db7e7c15f3ca076d53731445000001ba-1476140971.709362-1299813503', '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 16:17:18 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 16:17:18 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 16:17:18 INFO - Using env: {'DISPLAY': ':0', 16:17:18 INFO - 'HOME': '/home/cltbld', 16:17:18 INFO - 'LANG': 'en_US.UTF-8', 16:17:18 INFO - 'LANGUAGE': 'en_US:en', 16:17:18 INFO - 'LOGNAME': 'cltbld', 16:17:18 INFO - 'MAIL': '/var/mail/cltbld', 16:17:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:17:18 INFO - 'MOZ_NO_REMOTE': '1', 16:17:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:17:18 INFO - 'NO_EM_RESTART': '1', 16:17:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:17:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:17:18 INFO - 'PWD': '/builds/slave/test', 16:17:18 INFO - 'SHELL': '/bin/bash', 16:17:18 INFO - 'SHLVL': '1', 16:17:18 INFO - 'TERM': 'linux', 16:17:18 INFO - 'TMOUT': '86400', 16:17:18 INFO - 'USER': 'cltbld', 16:17:18 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1476140971.709362-1299813503', 16:17:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:17:18 INFO - '_': '/tools/buildbot/bin/python'} 16:17:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:17:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:17:18 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 16:17:18 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 16:17:18 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 16:17:18 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 16:17:18 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 16:17:18 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 16:17:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:17:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:17:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:17:20 INFO - Installing collected packages: mozsystemmonitor 16:17:20 INFO - Running setup.py install for mozsystemmonitor 16:17:20 INFO - Successfully installed mozsystemmonitor 16:17:20 INFO - Cleaning up... 16:17:20 INFO - Return code: 0 16:17:20 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:17:20 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')]} 16:17:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:17:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:17:20 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')]} 16:17:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:17:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:17:20 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 0x1bb9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d1c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1de8400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e77570>, '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 0x1e78470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e78900>, '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': 'db7e7c15f3ca076d53731445000001ba-1476140971.709362-1299813503', '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 16:17:20 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 16:17:20 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 16:17:20 INFO - Using env: {'DISPLAY': ':0', 16:17:20 INFO - 'HOME': '/home/cltbld', 16:17:20 INFO - 'LANG': 'en_US.UTF-8', 16:17:20 INFO - 'LANGUAGE': 'en_US:en', 16:17:20 INFO - 'LOGNAME': 'cltbld', 16:17:20 INFO - 'MAIL': '/var/mail/cltbld', 16:17:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:17:20 INFO - 'MOZ_NO_REMOTE': '1', 16:17:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:17:20 INFO - 'NO_EM_RESTART': '1', 16:17:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:17:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:17:20 INFO - 'PWD': '/builds/slave/test', 16:17:20 INFO - 'SHELL': '/bin/bash', 16:17:20 INFO - 'SHLVL': '1', 16:17:20 INFO - 'TERM': 'linux', 16:17:20 INFO - 'TMOUT': '86400', 16:17:20 INFO - 'USER': 'cltbld', 16:17:20 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1476140971.709362-1299813503', 16:17:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:17:20 INFO - '_': '/tools/buildbot/bin/python'} 16:17:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:17:21 INFO - Downloading/unpacking jsonschema==2.5.1 16:17:21 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 16:17:21 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 16:17:21 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 16:17:21 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 16:17:21 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 16:17:21 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 16:17:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:17:22 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:17:22 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 16:17:22 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 16:17:22 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 16:17:22 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 16:17:22 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 16:17:22 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 16:17:23 INFO - Downloading functools32-3.2.3-2.tar.gz 16:17:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:17:23 INFO - warning: no files found matching '*.txt' 16:17:23 INFO - no previously-included directories found matching 'build' 16:17:23 INFO - no previously-included directories found matching 'dist' 16:17:23 INFO - no previously-included directories found matching '.git*' 16:17:23 INFO - Installing collected packages: jsonschema, functools32 16:17:23 INFO - Running setup.py install for functools32 16:17:23 INFO - warning: no files found matching '*.txt' 16:17:23 INFO - no previously-included directories found matching 'build' 16:17:23 INFO - no previously-included directories found matching 'dist' 16:17:23 INFO - no previously-included directories found matching '.git*' 16:17:23 INFO - Successfully installed jsonschema functools32 16:17:23 INFO - Cleaning up... 16:17:23 INFO - Return code: 0 16:17:23 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:17:23 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')]} 16:17:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:17:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:17:23 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')]} 16:17:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:17:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:17:23 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 0x1bb9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d1c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1de8400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e77570>, '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 0x1e78470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e78900>, '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': 'db7e7c15f3ca076d53731445000001ba-1476140971.709362-1299813503', '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 16:17:23 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 16:17:23 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 16:17:23 INFO - Using env: {'DISPLAY': ':0', 16:17:23 INFO - 'HOME': '/home/cltbld', 16:17:23 INFO - 'LANG': 'en_US.UTF-8', 16:17:23 INFO - 'LANGUAGE': 'en_US:en', 16:17:23 INFO - 'LOGNAME': 'cltbld', 16:17:23 INFO - 'MAIL': '/var/mail/cltbld', 16:17:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:17:23 INFO - 'MOZ_NO_REMOTE': '1', 16:17:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:17:23 INFO - 'NO_EM_RESTART': '1', 16:17:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:17:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:17:23 INFO - 'PWD': '/builds/slave/test', 16:17:23 INFO - 'SHELL': '/bin/bash', 16:17:23 INFO - 'SHLVL': '1', 16:17:23 INFO - 'TERM': 'linux', 16:17:23 INFO - 'TMOUT': '86400', 16:17:23 INFO - 'USER': 'cltbld', 16:17:23 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1476140971.709362-1299813503', 16:17:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:17:23 INFO - '_': '/tools/buildbot/bin/python'} 16:17:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:17:23 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:17:23 INFO - Cleaning up... 16:17:23 INFO - Return code: 0 16:17:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:17:23 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')]} 16:17:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:17:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:17:23 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')]} 16:17:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:17:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:17:23 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 0x1bb9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d1c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1de8400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e77570>, '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 0x1e78470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e78900>, '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': 'db7e7c15f3ca076d53731445000001ba-1476140971.709362-1299813503', '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 16:17:23 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 16:17:23 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 16:17:23 INFO - Using env: {'DISPLAY': ':0', 16:17:23 INFO - 'HOME': '/home/cltbld', 16:17:23 INFO - 'LANG': 'en_US.UTF-8', 16:17:23 INFO - 'LANGUAGE': 'en_US:en', 16:17:23 INFO - 'LOGNAME': 'cltbld', 16:17:23 INFO - 'MAIL': '/var/mail/cltbld', 16:17:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:17:23 INFO - 'MOZ_NO_REMOTE': '1', 16:17:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:17:23 INFO - 'NO_EM_RESTART': '1', 16:17:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:17:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:17:23 INFO - 'PWD': '/builds/slave/test', 16:17:23 INFO - 'SHELL': '/bin/bash', 16:17:23 INFO - 'SHLVL': '1', 16:17:23 INFO - 'TERM': 'linux', 16:17:23 INFO - 'TMOUT': '86400', 16:17:23 INFO - 'USER': 'cltbld', 16:17:23 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1476140971.709362-1299813503', 16:17:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:17:23 INFO - '_': '/tools/buildbot/bin/python'} 16:17:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:17:23 INFO - Downloading/unpacking blobuploader==1.2.4 16:17:23 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 16:17:23 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 16:17:23 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 16:17:23 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 16:17:23 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 16:17:23 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 16:17:25 INFO - Downloading blobuploader-1.2.4.tar.gz 16:17:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:17:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:17:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:17:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:17:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:17:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:17:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:17:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:17:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:17:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:17:26 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 16:17:26 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 16:17:26 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 16:17:26 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 16:17:26 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 16:17:26 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 16:17:26 INFO - Downloading docopt-0.6.1.tar.gz 16:17:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:17:26 INFO - Installing collected packages: blobuploader, requests, docopt 16:17:26 INFO - Running setup.py install for blobuploader 16:17:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:17:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:17:26 INFO - Running setup.py install for requests 16:17:27 INFO - Running setup.py install for docopt 16:17:27 INFO - Successfully installed blobuploader requests docopt 16:17:27 INFO - Cleaning up... 16:17:27 INFO - Return code: 0 16:17:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:17:27 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')]} 16:17:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:17:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:17:27 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')]} 16:17:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:17:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:17:27 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 0x1bb9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d1c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1de8400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e77570>, '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 0x1e78470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e78900>, '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': 'db7e7c15f3ca076d53731445000001ba-1476140971.709362-1299813503', '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 16:17:27 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 16:17:27 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 16:17:27 INFO - Using env: {'DISPLAY': ':0', 16:17:27 INFO - 'HOME': '/home/cltbld', 16:17:27 INFO - 'LANG': 'en_US.UTF-8', 16:17:27 INFO - 'LANGUAGE': 'en_US:en', 16:17:27 INFO - 'LOGNAME': 'cltbld', 16:17:27 INFO - 'MAIL': '/var/mail/cltbld', 16:17:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:17:27 INFO - 'MOZ_NO_REMOTE': '1', 16:17:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:17:27 INFO - 'NO_EM_RESTART': '1', 16:17:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:17:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:17:27 INFO - 'PWD': '/builds/slave/test', 16:17:27 INFO - 'SHELL': '/bin/bash', 16:17:27 INFO - 'SHLVL': '1', 16:17:27 INFO - 'TERM': 'linux', 16:17:27 INFO - 'TMOUT': '86400', 16:17:27 INFO - 'USER': 'cltbld', 16:17:27 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1476140971.709362-1299813503', 16:17:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:17:27 INFO - '_': '/tools/buildbot/bin/python'} 16:17:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:17:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:17:27 INFO - Running setup.py (path:/tmp/pip-q7ZzxC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:17:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:17:27 INFO - Running setup.py (path:/tmp/pip-Mpoz2x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:17:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:17:27 INFO - Running setup.py (path:/tmp/pip-5GgytX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:17:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:17:27 INFO - Running setup.py (path:/tmp/pip-FhOc4g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:17:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:17:27 INFO - Running setup.py (path:/tmp/pip-k8Clh1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:17:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:17:27 INFO - Running setup.py (path:/tmp/pip-y7SvQS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:17:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:17:27 INFO - Running setup.py (path:/tmp/pip-r6QrxK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:17:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:17:27 INFO - Running setup.py (path:/tmp/pip-GCbhUO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:17:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:17:27 INFO - Running setup.py (path:/tmp/pip-F1_bSy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:17:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:17:28 INFO - Running setup.py (path:/tmp/pip-Z10zw2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:17:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:17:28 INFO - Running setup.py (path:/tmp/pip-5h3I59-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:17:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:17:28 INFO - Running setup.py (path:/tmp/pip-uI9wAg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:17:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:17:28 INFO - Running setup.py (path:/tmp/pip-KNRzwo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:17:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:17:28 INFO - Running setup.py (path:/tmp/pip-CH9TUf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:17:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:17:28 INFO - Running setup.py (path:/tmp/pip-TdkGQw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:17:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:17:28 INFO - Running setup.py (path:/tmp/pip-nVZ5k2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:17:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:17:28 INFO - Running setup.py (path:/tmp/pip-LSYgfO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:17:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:17:28 INFO - Running setup.py install for manifestparser 16:17:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:17:28 INFO - Running setup.py install for mozcrash 16:17:28 INFO - Running setup.py install for mozdebug 16:17:28 INFO - Running setup.py install for mozdevice 16:17:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:17:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:17:29 INFO - Running setup.py install for mozfile 16:17:29 INFO - Running setup.py install for mozhttpd 16:17:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:17:29 INFO - Running setup.py install for mozinfo 16:17:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:17:29 INFO - Running setup.py install for mozInstall 16:17:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:17:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:17:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:17:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:17:29 INFO - Running setup.py install for mozleak 16:17:29 INFO - Running setup.py install for mozlog 16:17:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:17:29 INFO - Running setup.py install for moznetwork 16:17:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:17:29 INFO - Running setup.py install for mozprocess 16:17:29 INFO - Running setup.py install for mozprofile 16:17:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:17:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:17:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:17:29 INFO - Running setup.py install for mozrunner 16:17:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:17:30 INFO - Running setup.py install for mozscreenshot 16:17:30 INFO - Running setup.py install for moztest 16:17:30 INFO - Running setup.py install for mozversion 16:17:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:17:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:17:30 INFO - Cleaning up... 16:17:30 INFO - Return code: 0 16:17:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:17:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:17:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:17:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:17:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:17:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:17:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:17:30 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 0x1bb9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d1c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1de8400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e77570>, '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 0x1e78470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e78900>, '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': 'db7e7c15f3ca076d53731445000001ba-1476140971.709362-1299813503', '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 16:17:30 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 16:17:30 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 16:17:30 INFO - Using env: {'DISPLAY': ':0', 16:17:30 INFO - 'HOME': '/home/cltbld', 16:17:30 INFO - 'LANG': 'en_US.UTF-8', 16:17:30 INFO - 'LANGUAGE': 'en_US:en', 16:17:30 INFO - 'LOGNAME': 'cltbld', 16:17:30 INFO - 'MAIL': '/var/mail/cltbld', 16:17:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:17:30 INFO - 'MOZ_NO_REMOTE': '1', 16:17:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:17:30 INFO - 'NO_EM_RESTART': '1', 16:17:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:17:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:17:30 INFO - 'PWD': '/builds/slave/test', 16:17:30 INFO - 'SHELL': '/bin/bash', 16:17:30 INFO - 'SHLVL': '1', 16:17:30 INFO - 'TERM': 'linux', 16:17:30 INFO - 'TMOUT': '86400', 16:17:30 INFO - 'USER': 'cltbld', 16:17:30 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1476140971.709362-1299813503', 16:17:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:17:30 INFO - '_': '/tools/buildbot/bin/python'} 16:17:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:17:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:17:30 INFO - Running setup.py (path:/tmp/pip-bfO0pr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:17:30 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)) 16:17:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:17:30 INFO - Running setup.py (path:/tmp/pip-mqB5HS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:17:30 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)) 16:17:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:17:30 INFO - Running setup.py (path:/tmp/pip-lEg8zI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:17:30 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)) 16:17:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:17:30 INFO - Running setup.py (path:/tmp/pip-98lP2J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:17:30 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)) 16:17:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:17:30 INFO - Running setup.py (path:/tmp/pip-o3q7mZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:17:30 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)) 16:17:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:17:31 INFO - Running setup.py (path:/tmp/pip-lckDxb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:17:31 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)) 16:17:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:17:31 INFO - Running setup.py (path:/tmp/pip-ERSsau-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:17:31 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)) 16:17:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:17:31 INFO - Running setup.py (path:/tmp/pip-tg48Cb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:17:31 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)) 16:17:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:17:31 INFO - Running setup.py (path:/tmp/pip-BSJjGP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:17:31 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)) 16:17:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:17:31 INFO - Running setup.py (path:/tmp/pip-AwnLn_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:17:31 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)) 16:17:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:17:31 INFO - Running setup.py (path:/tmp/pip-b1im8A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:17:31 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)) 16:17:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:17:31 INFO - Running setup.py (path:/tmp/pip-hdsIfS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:17:31 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)) 16:17:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:17:31 INFO - Running setup.py (path:/tmp/pip-xWkf9d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:17:31 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)) 16:17:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:17:31 INFO - Running setup.py (path:/tmp/pip-Gd5qbw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:17:31 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)) 16:17:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:17:31 INFO - Running setup.py (path:/tmp/pip-DX_joG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:17:31 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)) 16:17:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:17:31 INFO - Running setup.py (path:/tmp/pip-gRK3UZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:17:31 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)) 16:17:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:17:31 INFO - Running setup.py (path:/tmp/pip-e109NJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:17:31 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)) 16:17:31 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)) 16:17:31 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)) 16:17:31 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)) 16:17:31 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)) 16:17:31 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)) 16:17:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:17:31 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 16:17:31 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 16:17:31 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 16:17:31 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 16:17:31 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 16:17:31 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 16:17:33 INFO - Downloading blessings-1.6.tar.gz 16:17:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:17:33 INFO - Installing collected packages: blessings 16:17:33 INFO - Running setup.py install for blessings 16:17:33 INFO - Successfully installed blessings 16:17:33 INFO - Cleaning up... 16:17:34 INFO - Return code: 0 16:17:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:17:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:17:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:17:34 INFO - Reading from file tmpfile_stdout 16:17:34 INFO - Current package versions: 16:17:34 INFO - argparse == 1.2.1 16:17:34 INFO - blessings == 1.6 16:17:34 INFO - blobuploader == 1.2.4 16:17:34 INFO - docopt == 0.6.1 16:17:34 INFO - functools32 == 3.2.3-2 16:17:34 INFO - jsonschema == 2.5.1 16:17:34 INFO - manifestparser == 1.1 16:17:34 INFO - mozInstall == 1.12 16:17:34 INFO - mozcrash == 0.17 16:17:34 INFO - mozdebug == 0.1 16:17:34 INFO - mozdevice == 0.48 16:17:34 INFO - mozfile == 1.2 16:17:34 INFO - mozhttpd == 0.7 16:17:34 INFO - mozinfo == 0.9 16:17:34 INFO - mozleak == 0.1 16:17:34 INFO - mozlog == 3.3 16:17:34 INFO - moznetwork == 0.27 16:17:34 INFO - mozprocess == 0.23 16:17:34 INFO - mozprofile == 0.28 16:17:34 INFO - mozrunner == 6.12 16:17:34 INFO - mozscreenshot == 0.1 16:17:34 INFO - mozsystemmonitor == 0.3 16:17:34 INFO - moztest == 0.7 16:17:34 INFO - mozversion == 1.4 16:17:34 INFO - psutil == 3.1.1 16:17:34 INFO - requests == 1.2.3 16:17:34 INFO - wsgiref == 0.1.2 16:17:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:17: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')]} 16:17:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:17:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:17: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')]} 16:17:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:17:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:17:34 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 0x1bb9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d1c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1de8400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e77570>, '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 0x1e78470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e78900>, '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': 'db7e7c15f3ca076d53731445000001ba-1476140971.709362-1299813503', '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 16:17:34 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 16:17:34 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 16:17:34 INFO - Using env: {'DISPLAY': ':0', 16:17:34 INFO - 'HOME': '/home/cltbld', 16:17:34 INFO - 'LANG': 'en_US.UTF-8', 16:17:34 INFO - 'LANGUAGE': 'en_US:en', 16:17:34 INFO - 'LOGNAME': 'cltbld', 16:17:34 INFO - 'MAIL': '/var/mail/cltbld', 16:17:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:17:34 INFO - 'MOZ_NO_REMOTE': '1', 16:17:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:17:34 INFO - 'NO_EM_RESTART': '1', 16:17:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:17:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:17:34 INFO - 'PWD': '/builds/slave/test', 16:17:34 INFO - 'SHELL': '/bin/bash', 16:17:34 INFO - 'SHLVL': '1', 16:17:34 INFO - 'TERM': 'linux', 16:17:34 INFO - 'TMOUT': '86400', 16:17:34 INFO - 'USER': 'cltbld', 16:17:34 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1476140971.709362-1299813503', 16:17:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:17:34 INFO - '_': '/tools/buildbot/bin/python'} 16:17:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:17:34 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)) 16:17:34 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)) 16:17:34 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)) 16:17:34 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)) 16:17:34 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)) 16:17:34 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)) 16:17:34 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)) 16:17:34 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)) 16:17:34 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)) 16:17:34 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)) 16:17:34 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)) 16:17:34 INFO - Cleaning up... 16:17:34 INFO - Return code: 0 16:17:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:17: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')]} 16:17:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:17:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:17: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')]} 16:17:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:17:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:17:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bb9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d1c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1de8400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e77570>, '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 0x1e78470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e78900>, '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': 'db7e7c15f3ca076d53731445000001ba-1476140971.709362-1299813503', '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 16:17:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:17:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:17:34 INFO - Using env: {'DISPLAY': ':0', 16:17:34 INFO - 'HOME': '/home/cltbld', 16:17:34 INFO - 'LANG': 'en_US.UTF-8', 16:17:34 INFO - 'LANGUAGE': 'en_US:en', 16:17:34 INFO - 'LOGNAME': 'cltbld', 16:17:34 INFO - 'MAIL': '/var/mail/cltbld', 16:17:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:17:34 INFO - 'MOZ_NO_REMOTE': '1', 16:17:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:17:34 INFO - 'NO_EM_RESTART': '1', 16:17:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:17:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:17:34 INFO - 'PWD': '/builds/slave/test', 16:17:34 INFO - 'SHELL': '/bin/bash', 16:17:34 INFO - 'SHLVL': '1', 16:17:34 INFO - 'TERM': 'linux', 16:17:34 INFO - 'TMOUT': '86400', 16:17:34 INFO - 'USER': 'cltbld', 16:17:34 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1476140971.709362-1299813503', 16:17:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:17:34 INFO - '_': '/tools/buildbot/bin/python'} 16:17:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:17:34 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:17:34 INFO - Cleaning up... 16:17:34 INFO - Return code: 0 16:17:34 INFO - Running post-action listener: _resource_record_post_action 16:17:34 INFO - Running post-action listener: _start_resource_monitoring 16:17:34 INFO - Starting resource monitoring. 16:17:34 INFO - [mozharness: 2016-10-10 23:17:34.723738Z] Finished create-virtualenv step (success) 16:17:34 INFO - [mozharness: 2016-10-10 23:17:34.724222Z] Running install step. 16:17:34 INFO - Running pre-action listener: _resource_record_pre_action 16:17:34 INFO - Running main action method: install 16:17:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:17:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:17:34 INFO - Reading from file tmpfile_stdout 16:17:34 INFO - Detecting whether we're running mozinstall >=1.0... 16:17:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:17:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:17:35 INFO - Reading from file tmpfile_stdout 16:17:35 INFO - Output received: 16:17:35 INFO - Usage: mozinstall [options] installer 16:17:35 INFO - Options: 16:17:35 INFO - -h, --help show this help message and exit 16:17:35 INFO - -d DEST, --destination=DEST 16:17:35 INFO - Directory to install application into. [default: 16:17:35 INFO - "/builds/slave/test"] 16:17:35 INFO - --app=APP Application being installed. [default: firefox] 16:17:35 INFO - mkdir: /builds/slave/test/build/application 16:17:35 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'] 16:17:35 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 16:17:48 INFO - Reading from file tmpfile_stdout 16:17:48 INFO - Output received: 16:17:48 INFO - /builds/slave/test/build/application/firefox/firefox 16:17:48 INFO - Running post-action listener: _resource_record_post_action 16:17:48 INFO - [mozharness: 2016-10-10 23:17:48.518455Z] Finished install step (success) 16:17:48 INFO - [mozharness: 2016-10-10 23:17:48.518797Z] Running run-tests step. 16:17:48 INFO - Running pre-action listener: _resource_record_pre_action 16:17:48 INFO - Running main action method: run_tests 16:17:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:17:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:17:48 INFO - Python 2.7.3 16:17:48 INFO - Return code: 0 16:17:48 INFO - grabbing minidump binary from tooltool 16:17: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')]} 16:17:48 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 0x1e77570>, '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 0x1e78470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e78900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:17:48 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 16:17:48 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 16:17:48 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 16:17:48 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:17:48 INFO - Return code: 0 16:17:48 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:17:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:17:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:17:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:17:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:17:48 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/NcIysMkiS16GTAPmO-Y0Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--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 16:17:48 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/NcIysMkiS16GTAPmO-Y0Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-049 --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 16:17:48 INFO - Using env: {'DISPLAY': ':0', 16:17:48 INFO - 'HOME': '/home/cltbld', 16:17:48 INFO - 'LANG': 'en_US.UTF-8', 16:17:48 INFO - 'LANGUAGE': 'en_US:en', 16:17:48 INFO - 'LOGNAME': 'cltbld', 16:17:48 INFO - 'MAIL': '/var/mail/cltbld', 16:17:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:17:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:17:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:17:48 INFO - 'MOZ_NO_REMOTE': '1', 16:17:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:17:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:17:48 INFO - 'NO_EM_RESTART': '1', 16:17:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:17:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:17:48 INFO - 'PWD': '/builds/slave/test', 16:17:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:17:48 INFO - 'SHELL': '/bin/bash', 16:17:48 INFO - 'SHLVL': '1', 16:17:48 INFO - 'TERM': 'linux', 16:17:48 INFO - 'TMOUT': '86400', 16:17:48 INFO - 'USER': 'cltbld', 16:17:48 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1476140971.709362-1299813503', 16:17:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:17:48 INFO - '_': '/tools/buildbot/bin/python'} 16:17:48 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/NcIysMkiS16GTAPmO-Y0Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--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 16:17:48 INFO - mozversion application_buildid: 20161010141524 16:17:48 INFO - mozversion application_changeset: 0c41036b9e63facf1beb52b8ced744d525ca77d1 16:17:48 INFO - mozversion application_display_name: Firefox 16:17:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:17:48 INFO - mozversion application_name: Firefox 16:17:48 INFO - mozversion application_remotingname: firefox 16:17:48 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 16:17:48 INFO - mozversion application_vendor: Mozilla 16:17:48 INFO - mozversion application_version: 50.0 16:17:48 INFO - mozversion platform_buildid: 20161010141524 16:17:48 INFO - mozversion platform_changeset: 0c41036b9e63facf1beb52b8ced744d525ca77d1 16:17:48 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 16:17:48 INFO - mozversion platform_version: 50.0 16:17:48 INFO - using testdate: 1476141468 16:17:48 INFO - actual date: 1476141468 16:17:48 INFO - starting webserver on 'localhost:59690' 16:17:48 INFO - SUITE-START | Running 2 tests 16:17:48 INFO - TEST-START | dromaeo_css 16:17:48 INFO - operating with platform_type : linux_ 16:17:48 INFO - Initialising browser for dromaeo_css test... 16:17:48 INFO - TEST-INFO | started process 19340 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJINlL2/profile http://localhost:59690/getInfo.html) 16:17:53 INFO - PROCESS | 19340 | __metrics Screen width/height:1600/1200 16:17:53 INFO - PROCESS | 19340 | colorDepth:24 16:17:53 INFO - PROCESS | 19340 | Browser inner width/height: 1024/697 16:17:53 INFO - PROCESS | 19340 | __metrics 16:17:54 ERROR - PROCESS | 19340 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 16:17:54 INFO - TEST-INFO | 19340: exit 0 16:17:54 INFO - Browser initialized. 16:17:54 INFO - Running cycle 1/1 for dromaeo_css test... 16:17:54 INFO - TEST-INFO | started process 19461 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJINlL2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:18:06 INFO - PROCESS | 19461 | RSS: Main: 149897216 16:18:06 INFO - PROCESS | 19461 | 16:18:56 INFO - PROCESS | 19461 | 1476141536181 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] 16:21:04 INFO - PROCESS | 19461 | Cycle 1(1): loaded http://localhost:59690/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59690/tests/dromaeo/cssquery-ext.html) 16:21:05 INFO - PROCESS | 19461 | RSS: Main: 158478336 16:21:05 INFO - PROCESS | 19461 | 16:24:07 INFO - PROCESS | 19461 | Cycle 1(1): loaded http://localhost:59690/tests/dromaeo/cssquery-ext.html (next: http://localhost:59690/tests/dromaeo/cssquery-jquery.html) 16:24:08 INFO - PROCESS | 19461 | RSS: Main: 155033600 16:24:08 INFO - PROCESS | 19461 | 16:27:10 INFO - PROCESS | 19461 | Cycle 1(1): loaded http://localhost:59690/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59690/tests/dromaeo/cssquery-mootools.html) 16:27:10 INFO - PROCESS | 19461 | RSS: Main: 154472448 16:27:10 INFO - PROCESS | 19461 | 16:30:12 INFO - PROCESS | 19461 | Cycle 1(1): loaded http://localhost:59690/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59690/tests/dromaeo/cssquery-prototype.html) 16:30:13 INFO - PROCESS | 19461 | RSS: Main: 156098560 16:30:13 INFO - PROCESS | 19461 | 16:33:15 INFO - PROCESS | 19461 | Cycle 1(1): loaded http://localhost:59690/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59690/tests/dromaeo/cssquery-yui.html) 16:33:16 INFO - PROCESS | 19461 | RSS: Main: 157216768 16:33:16 INFO - PROCESS | 19461 | 16:36:18 INFO - PROCESS | 19461 | Cycle 1(1): loaded http://localhost:59690/tests/dromaeo/cssquery-yui.html (next: http://localhost:59690/tests/dromaeo/cssquery-dojo.html) 16:36:19 INFO - PROCESS | 19461 | RSS: Main: 157179904 16:36:19 INFO - PROCESS | 19461 | 16:36:19 INFO - PROCESS | 19461 | __start_tp_report 16:36:19 INFO - PROCESS | 19461 | _x_x_mozilla_page_load 16:36:19 INFO - PROCESS | 19461 | _x_x_mozilla_page_load_details 16:36:19 INFO - PROCESS | 19461 | |i|pagename|runs| 16:36:19 INFO - PROCESS | 19461 | |0;dojo.html;3277.0496555998757;3296.1924328539503;3296.1924328539512;3314.651961544036;3333.7833040852342;5652.09566469365;5669.09294512878;5671.886562268752;5674.914876276859;5676.631018983769;5655.971720141393;5719.027765279902;5719.628224165426;5728.742206600703;5732.455416735404;5183.248428977796;5198.714070726109;5216.400113986883;5258.44786297439;5277.366715994067;5256;5276.393214780292;5276.551493123089;5283.022640811462;5301.257823904637;5076.162433198518;5090.134677104883;5263.736813159346;5269.341332333458;5276.366835979668;5092.108880945838;5102.438731739506;5131.435542090367;5205.739713014372;5206.062908676437;5077.390713114413;5163.277141200198;5173.9741301293625;5174.197999310113;5213.687178769286;5506.807261745819;5590.8043218487155;5599.7480113394995;5644.266245388114;5690.146478028288;5913.05391137416;5945.970270148665;5978.342382337939;6040.939590604125;6051.062085376773;6024.09638554216;6046.093086037085;6050.788222412194;6057.848553786146;6092.908606370908;5448.618596698193;5662.886742265132;5666.405027472098;5670.0360938640115;5672.12082127271;6032.065029920369;6061.424164704435;6067.484263837535;6129.664444256096;6130.031268545464;5826.359100498942;5875.001249787546;5885.882282354329;5889.38161493037;5903.527717782567;5907.1434641976675;5933;5977.342492325841;5980.700964951822;5987.730552125165;5975.970120149458;5997.790077347359;6026.216591843032;6095.634261944298;6136.6624835633575;6069.726862291208;6086.239220097488;6094.177286066413;6099.664518451527;6110.083487476914;4561.954380456219;4692.741899195509;4697.177993851131;4698.036902434993;4709.835155769531;4106.568810274938;4108.301588729923;4154.086101057763;4182.9581704182565;4209.579042095827;5789.044807606782;5852.502537284378;5858.209141765807;5860.091685788624;5861.296644402613;5932.940670593325;6128.724207410677;6141.048137538689;6142.170806941095;6143.84640383994;5628.493435590734;5704.629199102128;5709.457601527848;5741.1388291756575;5741.712914354265;4946.060248552835;4991.4758950310425;5018.573421259161;5019.14674505335;5027.522385373383;5954.85112872173;6031.276246850406;6051.939480605138;6072.848178795565;6095;5911.083782013795;5988.341282458839;6006.789762358297;6011.6693581853415;6013.849653758691;6188.133661287513;6220.409061139185;6252.812415627538;6264.31092579825;6265.655388953469;5849.590528663123;5862.267216597926;5906.645601263938;5937.554683398676;5953.28560572734;5931.258592675916;6019.6990150493175;6025.216721826135;6058.909116363347;6063.211782468251;5764.913526297025;5842.970785146047;5849.239598852122;5853.765849366148;5881.206037184926;5516.889662206813;5810.564207684356;5820.214271073521;5822.796202132905;5824.475797178275;5775.364709881826;5881.588288819913;5885;5901.350851406256;5937.8218653438735;5853.35613082552;5911.083782013795;5945.167676525376;5971.58198926071;5989;5644.491995720405;5670.206171135962;5815.912761308668;5825.592208545361;5839.124131380327 16:36:19 INFO - PROCESS | 19461 | |1;ext.html;585.8857522783056;633.471051671854;643.1767337807606;645.6578013652763;655.7868692674882;33840.66159338406;45897.31154032688;47025.29462058072;47102.764486177606;47233.763831180884;48170.75914620422;48722.75638621802;48901.51098489014;48980.26529602059;49068.754656226665;9337;9481.62073517062;9499.667511637093;9501.80996380072;9510.524473776319;9318.76703082425;9353.67262145825;9387.906120938806;9390.389624674408;9404.106609872051;9353.67262145825;9420.670276540322;9442.291828112884;9447;9482.857757133648;9352.719418417459;9392.24862011041;9406.2945279104;9406.811863762687;9415.058494150599;9334.813303733956;9345.485998270093;9372.015938326445;9390.577424015935;9394.62421503139;44367;44400.555994439965;44529.33206001913;44662.10675786466;44913.77543112264;4031.516218053823;4331.7617531035785;4580.221362368372;4659.138059459011;4675.135100006476;34711.479327810106;35084.473732894025;35374.115647108774;35495.64504354949;36692.44961325582;4692.671512994092;4734.763261836894;4735.550122738335;4740.2889566564945;4808;368097;368955;369234;370586;372631;61947.38052619506;62418.375816242165;62603;62609.68695156586;62718;39290.214195715926;39779.80110099431;40024.59975400209;42139.57860421418;42428;19368.225270989285;19615.901920490305;19656.90171549162;19663.311784087487;19679;12956.157849739737;13081.084324097412;13087.083904126619;13115.950723942062;13148.211107333591;20535;20795.480112997295;20943.581128377653;20971.26600568973;21066.36800895945;7530.359919406802;7585.431092667962;7623.123340815877;7798.883016754639;7802.336801371947;1049.454283772434;1072.8605281313535;1107.2747350485445;1144.6623246142408;1146.4095990564865;34109.65890341065;34212.65787342144;34264;34448;34616.48075278873;1150.551284998851;1161.8257261410688;1180.3390101543164;1211.7697637448857;1261.9242845429303;17379.217935192948;17851.875027935395;17982.550436238937;18053.909730451527;18134.09329533518;590291;594218;600491;600496;602541;63844.680776596746;64428.35571644317;64610.67694661496;64650.676746615965;64798.352016479235;1428.5784513737842;1459.3360021190333;1471.9926400367929;1472.8306244781772;1481.1335368809152;33031.83484082564;33409;33733.3253334927;33733.66266337403;34417.48373774345;59700;62320.68839655773;62349;67716.6614166926;67988.6600566994;554301;558642;558953;558997;559097;48354;48966.75516622394;48976;49136.50863491462;49912.75043624759;52668.47331526789;52867;52883.735581321846;53734;54307;44679.32981005222;45872.54127458682;46510.53489465062;47035.529644703114;47357.76321118372;44633.33050004188;45778.54221457876;46099;46641.300380495;46732.53267467282;44707.552924470336;44850.775746121064;45552.08895822131;45646;46099.539004610866;38307;39508.40737388999;39933.8643327779;40007.39988900227;40536.59463405328;30014.699853002065;30364.544531832482;30702;30954.69045309518;30962.22594435067 16:36:19 INFO - PROCESS | 19461 | |2;jquery.html;408.75474715170884;410.4827916824802;421.275406301162;428.60568277184996;430.51782004155353;19511.219551217953;20711.446641501872;21265.14939402424;22234.332970010884;22396.440088997784;20343.389698309038;20605.1757929683;20627.27804526842;20950.895245523752;21173.364799056053;5943.88112237755;6119.571629985903;6145.477634401082;6146.692665366736;6154.969225153868;5317.574594032488;5571.8607034824045;5617.185508101323;6029.457348838604;6055.122007308938;5524.254225679522;5682.914756278659;5708.200851880719;5709.571782116337;5711.228984087157;5792.565557583177;5925.8814823703715;5928.3775203603645;5937.22816033915;5953.196318496991;4916.1888288432365;5161.896762064775;5177.870553236162;5217.947820521822;5225.686458812484;13377.73244535104;14964;23616.52766944669;24373.26880193597;24724.25827225186;2360.7875291223872;2362.6692263083182;2586.2241327601832;2964.673885872552;3009.623797025372;9987.450690212036;10016.348937319051;10222.9488852556;10249.282550221487;14708.926455367655;1891.1017266798299;1956.3935180094215;1971.2607772085469;1972.1224055295256;1982.3260091568936;84166.57916710438;85942;87028.56485717594;87803.56098219533;91043;11043.392613406178;11196.104311655212;11254.15593830466;11318.886811131948;11733.589324373606;16396.83603163977;16439.91780041092;16440.917795411187;16468.341266349453;16541.338346466247;8237.50574965504;8308.667653293922;8349.206825351583;8536.573171341408;8548.102449242864;7998.440109192301;8021.799455013671;8170.591470426455;8189.22202390772;8253.257206851293;4940.061388336277;4973.5523802857915;5050.393952725696;5090.898182036339;5179.482051794866;2081.7621057363394;2088.6762551804495;2093.13135048956;2138.7219661443914;2162.7296587926508;941.5292353823088;1014.6702321745462;1084.8481212630238;1095.7370231144469;1108.6396921000708;19458.902705486384;20748.48128796762;21289.254876079263;21376.679349809765;21589.78410215909;1021.8569400283966;1027.5324727249083;1031.1493018259816;1039.111559616532;1066.7119877632995;11511.136664750176;11598;11737.178397512092;11852;11913.940430297793;519752;521429;533320;536447;546864;95476;98500.50749746205;100091;101522.49238753758;101552.49223753835;1049.2655141401049;1058.4972138234277;1060.6605886116522;1066.328213225663;1088.5482524752297;18127.36554220596;18398.448046558624;18687.159077841803;18907.177990994718;18996.050197490345;42485.57514424816;43754.78122609366;44966.325505118104;45963;46355.999999998654;57657.711711441174;57745;62544;64524.35475645184;65287.347126528126;8116.75649730509;8775.385722999328;9048.547572621474;9240.029796871231;9274.072592740671;13494.52769153075;13583.79624305656;13865.168089914638;14445;14475.420983160555;11965;11970.401479925795;12576.245425274512;12641.93679031599;13093;12160.331181785086;12375.133740638068;12502.562410315595;12729.29988850622;12965.091687193726;11481.655550333504;11655.41722913834;12468.376581171087;12616.810747838974;12969.092163548838;8050.114487406264;8152.2662960333855;8219.671213151407;8223.794405139919;8366;9989.800203996025;12363.134580579273;12368.381580921097;12544;12612.810807837706 16:36:19 INFO - PROCESS | 19461 | |3;mootools.html;1510.6072421170493;1523.0709267346917;1665.0758828849982;1806.8644851636132;1820.217306558181;8701;9029.097090290968;9301.95349023254;9346.158845703885;9438.292128090403;9083.682071127512;9202.677906273282;9224.907750922488;9262.444253344804;9290.489023103726;2278.7949084582424;2339.894704738291;2349.835511514195;2351.9647205291935;2352.7882490575844;2260.785225403584;2296.9310920672324;2371.6679664846934;2372.54921564903;2375.786179243876;2337.532493501298;2342.367560758594;2345.554344674515;2346.894389752457;2360.4570948681812;2317.6639387288833;2319.246244970391;2338.7661233876647;2342.355852140658;2343.320437073247;2320.7447180810095;2320.8375413721046;2324.2213858357472;2328.6507023946374;2336.953260934789;9129;9191.862122068174;9209.907900920973;9216.262698984065;9228.077192280785;5316.9734151329385;5386.91919621206;5467.0705979983495;5529.391766905637;5533.170024496358;3450.9992102290307;3487.668671476206;3515.0860776198115;3581.713462922986;3604.080959355374;1102.1348241630283;1116.4696769034645;1122.5004872831594;1139.6011396011413;1144.7824913266536;12456.75086498274;12549.247045177228;12553.246805191719;12576.81134782979;12610.81083783744;4461.442319710036;4518.548145185455;4631.58315751584;4633.050224703928;4657.69724967876;10064.295499314978;10065.094141527297;10067.244956628136;10076.69769906904;10083.14293285079;5343.118385466354;5345.86635334112;5363.249145119687;5377.704226267593;5386.13821788512;4948.579370753526;5044.9495505045215;5098.694078355311;5135.6405051646025;5189.065968125774;3724.5530536335814;3808.5429748430365;3857.3056849767313;3873.6126387361037;3883.0874744435037;1125.21797350842;1129.2603344809163;1132.4960392625203;1142.0920368307216;1151.1423989127986;1014.802113587858;1044.9738756530996;1062.7077553672648;1064.7817197474499;1077.5689724110418;6069.02895536712;6157.507399408037;6183.5671502994355;6244.344343843922;6247.625142491465;478.6147151542972;488.1359992812702;500.4161827814925;506.2684421011603;507.5127877237819;4449.421575195269;4544.545545445429;4564.360989461478;4607.953920460753;4645.094206629675;10824.891751082389;11327.60353387644;11338.206325557132;11341.319520828776;11360.659180224606;10623.415712135753;11118.666440006651;11297;11323.830142547868;11343.149263805248;8434.15658434164;8595.5702214889;8640.567971601395;8647.827043459096;8654.264387527004;6138.263408391022;6285.214348206474;6292.867283888944;6427.389398007182;6548.410643042149;10459.529321180717;10468.738281543023;10570.577176913144;10647.467626618483;10728.409937453514;10041.648542300984;10341.896581034394;10679.359238445719;10843.45782710877;10843.620473283398;7839.216078392344;7861.371090312647;8233.50598964064;8254.752357429286;8279.62741676638;9018.5941632628;9075.954620226856;9092.181703646704;9097.454152750855;9101.044390338919;7084.752033678797;7202.747903823551;7267.454940879349;7271.781846544613;7536.472446928662;7933.920660793318;8038.39712021589;8049.154838741848;8087.3125784308995;8122.065962414398;7556.546607203585;7673.424493162924;7680.577568233801;7689.8462030757955;7696.7306144284685;5501.257330260363;5604.355499117653;5648.57635677334;5674.886502270014;5679.148127780701;5523.8895222096135;5526.91709624364;5622.634528755618;5666.433356664301;5694.515966142924 16:36:19 INFO - PROCESS | 19461 | |4;prototype.html;344.9327381160674;346.9176367970582;354.0928973130598;354.6081579854261;358.01902786365366;5737.569682273831;5750.511206547443;5765.3369862465825;5781;5789.681567513785;5673.574481913853;5703.344115426717;5706.258186435768;5709.34429015585;5721.485066344028;4074.1851629674034;4425.955740442602;4463.642908567307;4468.374427580141;4472.44094488189;4457.799399027035;4458.732476051431;4461.39771130898;4474.865754027384;4477.171723231197;4439.400680908068;4440.800163992628;4445.711028783118;4450.777461126947;4455.331700244957;4296.591823776736;4367.54140815213;4438.977805110986;4448.57645553423;4458.910821783546;3945.9210815783813;3952.920941581181;3959.227950549644;3971.344728119857;3988.8631739953976;5536.944630553683;5541.556675465953;5556.611037227396;5567.248421463131;5585.413531579207;5073.097588404348;5113.974430127825;5147.871303217412;5150.021495915801;5156.793728250866;5921.319048309457;5926.140709597084;5945.346011938684;5973.492253158443;5982.970085149546;4306.849260275875;4372.781360931941;4378.452693413324;4380.671449641258;4380.824767009316;6151.200343955302;6159.81520554384;6227.287495938653;6233.877901977642;6264.436200741955;4476.37330773692;4493.528179541101;4517.277235642281;4519.7740112994215;4538.2738761797955;4426.889327766831;4522.592966632953;4575.611073058827;4589.426321709786;4590.88522786933;5104.668196567211;5145.562627176732;5153.845384638467;5158.509941555546;5172.112179054693;5961.970190149108;6016.187814644967;6038.909416358758;6060.33336333003;6063.7574497020505;1523.2155439948435;1566.749320108777;1568.9607759806097;1576.2355257700005;1581.841815818409;1000.7540611938183;1014.4116412480744;1017.1252722658508;1057.9682609521726;1098.774751176007;5702.971485142631;5725.6850873202375;5743.741531631086;5763.221965034667;5792.8551786204835;6033.909491357633;6058.57589968698;6078.6048906820915;6080.209572755602;6083.300420451616;5624.521915637135;5704.258446402024;5754.280714910637;5779.566532509994;5794.362620111784;3230.5623997321436;3267.5949341782784;3269.150020994511;3270.8201048942537;3275.2139486523065;6109.877802443926;6311.990081586924;6318.968405157945;6320.273168585672;6369.1847823371045;6211.254649442096;6216.595921265103;6227.564070515111;6259.2488901332135;6260.998240281533;6033.7586496540525;6280.963640999275;6350.412017210261;6369.490440764727;6397.392247736458;6009.429104235091;6016.157737916783;6016.819495415145;6054.485368743706;6087.57386982907;5999.720106359556;6008.5493587981955;6013.3685962975005;6048.153258543719;6055.878882422415;6216.658083805434;6228.418659270847;6452.483801295979;6473.611583305017;6476.740930362733;4369.497507786518;4434.3791869138995;4440.444944381952;4451.065276291885;4467.932981005222;6135.539834512519;6228.875422491434;6259.843503912439;6280.654563999024;6299.307076221704;6029.728662210299;6047.697615119315;6055.848603784941;6058.4244496772735;6069.757209711562;6013.458788709037;6021.729022194099;6023.27720673522;6029;6035.969820150871;5815.563832712479;5864.208331875142;5916.201312822714;5932.377100404396;5940.544566581042;6017.638941663514;6020.638761674313;6094.8171554853425;6112.410773199089;6115.602485838406;5942.910856337245;5950.3339065061855;5965.224520812267;5967.8209653710455;5980.0431930890845 16:36:19 INFO - PROCESS | 19461 | |5;yui.html;784.8037990502378;794.4994653368377;798.2456578533286;806.2904643913355;901.3420203251626;13787.448502059919;14345.78481322781;14429.062110962781;14458.566243012714;14517.346719397627;13657.521986730466;13749.450021999108;13756.243406612657;16005.919970400131;16273.593160170973;863.3136656358195;873.6723728601775;876.6055275126218;878.323690758119;880.0935036911991;854.372036553133;856.8500512410303;859.9527026013567;878.0253918150879;895.8163576466841;921.5392303848076;923.4413180026088;924.2282693950559;926.3885835348672;927.0451435021938;923.487464457226;932.305432452827;932.7761337279038;933.2533972821749;933.3793027636614;683.3883674111643;685.9622720750357;686.8111269400905;686.8317262270775;687.182253118787;16508.587285317844;16517.091559964196;16533.50399488017;16552.255148518227;16621.085840278778;14229.359678814375;14632.561023169323;14689;14717.484888028976;14796.556103316918;13393.531226407127;13412.26232557209;13559.59321220365;13654.863451365458;13735.793963090562;3972.324704800191;3977.164795392971;3984.4222587724907;4003.5996400360023;4066.3493840985598;85768.57115714444;86398;86592;86764.13235867687;87336.56331718364;12369.443375048144;12413.255204687748;12662.430190641444;12810.9359453204;12975.22148671064;23438.531229375316;23446.64830027551;23482.88258558696;23503.647445288334;23690.526189476113;9104.13510716494;9220.354575179806;9338.393004454689;9402.294827887936;9572.76068098303;5404.729888476205;5410.080286351251;5431.429699881534;5485.643433176911;5510.201020851954;3791.3933770597123;3849.1147036181274;3867.0525721198487;3877.2051729395407;3913.3738601824143;666.1573110015834;683.3474032299142;684.5174152222671;700.663681432915;703.7044441334651;748.5134662469329;801.6152246921393;809.6437567470412;834.6202477872674;838.9286910612666;10017.148542373834;10168.678071850612;10277.280590358603;10297.845532317022;10333.22500812442;634.946029587481;720.8306048078697;746.4177941205868;758.7382353088176;766.4404984361447;4412.301264013314;4457.910841783211;4715.198416269242;4741.146593613183;5021.321164060703;129881.35059324832;131121.34439327742;133792.33103834614;134005.32997334952;136546;65273;68721.3127868715;69979.30020699727;83258.58370708229;91875.08124918799;72799.2720072803;96497;98281;98789;100125;10199.490025498844;10497.016700480957;10554.10290125348;10644.467776611293;10651.627193048205;49000.26499602437;57301.42698572961;57596.71201643965;57991;58532.4146758527;49368.75315623399;66580.66709666421;71989.6400517994;73945.41438893463;76983.61508192647;13980.930095349458;14036.649083772987;14906.478273260384;14945.178015209269;15027.09837409759;15233.23833808283;15370.077795332316;16651.167441628113;17301.826981730526;18141.537848804237;14815;15276;15298.158601277037;15436.151011694465;16359.509214723577;14569.271536422924;15144.394224230908;15458.227088645748;15519.612009699847;15528;13657.248851313274;14157.716845663235;14344.211068390921;14893.404263829325;14909.552713418614;11543.94228028888;12690.11169218146;12746.426410811351;13048.347582620641;13425.530106446227;13142.540011099565;13212.273324967218;13218.140820846615;13291.867081329063;13345.466181352636 16:36:19 INFO - PROCESS | 19461 | __end_tp_report 16:36:19 INFO - PROCESS | 19461 | __start_cc_report 16:36:19 INFO - PROCESS | 19461 | _x_x_mozilla_cycle_collect,348 16:36:19 INFO - PROCESS | 19461 | __end_cc_report 16:36:19 INFO - PROCESS | 19461 | __startTimestamp1476142579045__endTimestamp 16:36:19 INFO - PROCESS | 19461 | 16:36:19 INFO - PROCESS | 19461 | ------- Summary: start ------- 16:36:19 INFO - PROCESS | 19461 | Number of tests: 6 16:36:19 INFO - PROCESS | 19461 | 16:36:19 INFO - PROCESS | 19461 | [#0] dojo.html Cycles:165 Average:5601.35 Median:5826.36 stddev:614.08 (10.5%) stddev-sans-first:588.27 16:36:19 INFO - PROCESS | 19461 | Values: 3277.0 3296.2 3296.2 3314.7 3333.8 5652.1 5669.1 5671.9 5674.9 5676.6 5656.0 5719.0 5719.6 5728.7 5732.5 5183.2 5198.7 5216.4 5258.4 5277.4 5256.0 5276.4 5276.6 5283.0 5301.3 5076.2 5090.1 5263.7 5269.3 5276.4 5092.1 5102.4 5131.4 5205.7 5206.1 5077.4 5163.3 5174.0 5174.2 5213.7 5506.8 5590.8 5599.7 5644.3 5690.1 5913.1 5946.0 5978.3 6040.9 6051.1 6024.1 6046.1 6050.8 6057.8 6092.9 5448.6 5662.9 5666.4 5670.0 5672.1 6032.1 6061.4 6067.5 6129.7 6130.0 5826.4 5875.0 5885.9 5889.4 5903.5 5907.1 5933.0 5977.3 5980.7 5987.7 5976.0 5997.8 6026.2 6095.6 6136.7 6069.7 6086.2 6094.2 6099.7 6110.1 4562.0 4692.7 4697.2 4698.0 4709.8 4106.6 4108.3 4154.1 4183.0 4209.6 5789.0 5852.5 5858.2 5860.1 5861.3 5932.9 6128.7 6141.0 6142.2 6143.8 5628.5 5704.6 5709.5 5741.1 5741.7 4946.1 4991.5 5018.6 5019.1 5027.5 5954.9 6031.3 6051.9 6072.8 6095.0 5911.1 5988.3 6006.8 6011.7 6013.8 6188.1 6220.4 6252.8 6264.3 6265.7 5849.6 5862.3 5906.6 5937.6 5953.3 5931.3 6019.7 6025.2 6058.9 6063.2 5764.9 5843.0 5849.2 5853.8 5881.2 5516.9 5810.6 5820.2 5822.8 5824.5 5775.4 5881.6 5885.0 5901.4 5937.8 5853.4 5911.1 5945.2 5971.6 5989.0 5644.5 5670.2 5815.9 5825.6 5839.1 16:36:19 INFO - PROCESS | 19461 | 16:36:19 INFO - PROCESS | 19461 | [#1] ext.html Cycles:180 Average:68004.80 Median:25584.84 stddev:137672.42 (538.1%) stddev-sans-first:137965.57 16:36:19 INFO - PROCESS | 19461 | Values: 585.9 633.5 643.2 645.7 655.8 33840.7 45897.3 47025.3 47102.8 47233.8 48170.8 48722.8 48901.5 48980.3 49068.8 9337.0 9481.6 9499.7 9501.8 9510.5 9318.8 9353.7 9387.9 9390.4 9404.1 9353.7 9420.7 9442.3 9447.0 9482.9 9352.7 9392.2 9406.3 9406.8 9415.1 9334.8 9345.5 9372.0 9390.6 9394.6 44367.0 44400.6 44529.3 44662.1 44913.8 4031.5 4331.8 4580.2 4659.1 4675.1 34711.5 35084.5 35374.1 35495.6 36692.4 4692.7 4734.8 4735.6 4740.3 4808.0 368097.0 368955.0 369234.0 370586.0 372631.0 61947.4 62418.4 62603.0 62609.7 62718.0 39290.2 39779.8 40024.6 42139.6 42428.0 19368.2 19615.9 19656.9 19663.3 19679.0 12956.2 13081.1 13087.1 13116.0 13148.2 20535.0 20795.5 20943.6 20971.3 21066.4 7530.4 7585.4 7623.1 7798.9 7802.3 1049.5 1072.9 1107.3 1144.7 1146.4 34109.7 34212.7 34264.0 34448.0 34616.5 1150.6 1161.8 1180.3 1211.8 1261.9 17379.2 17851.9 17982.6 18053.9 18134.1 590291.0 594218.0 600491.0 600496.0 602541.0 63844.7 64428.4 64610.7 64650.7 64798.4 1428.6 1459.3 1472.0 1472.8 1481.1 33031.8 33409.0 33733.3 33733.7 34417.5 59700.0 62320.7 62349.0 67716.7 67988.7 554301.0 558642.0 558953.0 558997.0 559097.0 48354.0 48966.8 48976.0 49136.5 49912.8 52668.5 52867.0 52883.7 53734.0 54307.0 44679.3 45872.5 46510.5 47035.5 47357.8 44633.3 45778.5 46099.0 46641.3 46732.5 44707.6 44850.8 45552.1 45646.0 46099.5 38307.0 39508.4 39933.9 40007.4 40536.6 30014.7 30364.5 30702.0 30954.7 30962.2 16:36:19 INFO - PROCESS | 19461 | 16:36:19 INFO - PROCESS | 19461 | [#2] jquery.html Cycles:180 Average:31037.14 Median:22315.39 stddev:87697.71 (393.0%) stddev-sans-first:87913.57 16:36:19 INFO - PROCESS | 19461 | Values: 408.8 410.5 421.3 428.6 430.5 19511.2 20711.4 21265.1 22234.3 22396.4 20343.4 20605.2 20627.3 20950.9 21173.4 5943.9 6119.6 6145.5 6146.7 6155.0 5317.6 5571.9 5617.2 6029.5 6055.1 5524.3 5682.9 5708.2 5709.6 5711.2 5792.6 5925.9 5928.4 5937.2 5953.2 4916.2 5161.9 5177.9 5217.9 5225.7 13377.7 14964.0 23616.5 24373.3 24724.3 2360.8 2362.7 2586.2 2964.7 3009.6 9987.5 10016.3 10222.9 10249.3 14708.9 1891.1 1956.4 1971.3 1972.1 1982.3 84166.6 85942.0 87028.6 87803.6 91043.0 11043.4 11196.1 11254.2 11318.9 11733.6 16396.8 16439.9 16440.9 16468.3 16541.3 8237.5 8308.7 8349.2 8536.6 8548.1 7998.4 8021.8 8170.6 8189.2 8253.3 4940.1 4973.6 5050.4 5090.9 5179.5 2081.8 2088.7 2093.1 2138.7 2162.7 941.5 1014.7 1084.8 1095.7 1108.6 19458.9 20748.5 21289.3 21376.7 21589.8 1021.9 1027.5 1031.1 1039.1 1066.7 11511.1 11598.0 11737.2 11852.0 11913.9 519752.0 521429.0 533320.0 536447.0 546864.0 95476.0 98500.5 100091.0 101522.5 101552.5 1049.3 1058.5 1060.7 1066.3 1088.5 18127.4 18398.4 18687.2 18907.2 18996.1 42485.6 43754.8 44966.3 45963.0 46356.0 57657.7 57745.0 62544.0 64524.4 65287.3 8116.8 8775.4 9048.5 9240.0 9274.1 13494.5 13583.8 13865.2 14445.0 14475.4 11965.0 11970.4 12576.2 12641.9 13093.0 12160.3 12375.1 12502.6 12729.3 12965.1 11481.7 11655.4 12468.4 12616.8 12969.1 8050.1 8152.3 8219.7 8223.8 8366.0 9989.8 12363.1 12368.4 12544.0 12612.8 16:36:19 INFO - PROCESS | 19461 | 16:36:19 INFO - PROCESS | 19461 | [#3] mootools.html Cycles:180 Average:5992.54 Median:4619.77 stddev:3425.84 (74.2%) stddev-sans-first:3418.89 16:36:19 INFO - PROCESS | 19461 | Values: 1510.6 1523.1 1665.1 1806.9 1820.2 8701.0 9029.1 9302.0 9346.2 9438.3 9083.7 9202.7 9224.9 9262.4 9290.5 2278.8 2339.9 2349.8 2352.0 2352.8 2260.8 2296.9 2371.7 2372.5 2375.8 2337.5 2342.4 2345.6 2346.9 2360.5 2317.7 2319.2 2338.8 2342.4 2343.3 2320.7 2320.8 2324.2 2328.7 2337.0 9129.0 9191.9 9209.9 9216.3 9228.1 5317.0 5386.9 5467.1 5529.4 5533.2 3451.0 3487.7 3515.1 3581.7 3604.1 1102.1 1116.5 1122.5 1139.6 1144.8 12456.8 12549.2 12553.2 12576.8 12610.8 4461.4 4518.5 4631.6 4633.1 4657.7 10064.3 10065.1 10067.2 10076.7 10083.1 5343.1 5345.9 5363.2 5377.7 5386.1 4948.6 5044.9 5098.7 5135.6 5189.1 3724.6 3808.5 3857.3 3873.6 3883.1 1125.2 1129.3 1132.5 1142.1 1151.1 1014.8 1045.0 1062.7 1064.8 1077.6 6069.0 6157.5 6183.6 6244.3 6247.6 478.6 488.1 500.4 506.3 507.5 4449.4 4544.5 4564.4 4608.0 4645.1 10824.9 11327.6 11338.2 11341.3 11360.7 10623.4 11118.7 11297.0 11323.8 11343.1 8434.2 8595.6 8640.6 8647.8 8654.3 6138.3 6285.2 6292.9 6427.4 6548.4 10459.5 10468.7 10570.6 10647.5 10728.4 10041.6 10341.9 10679.4 10843.5 10843.6 7839.2 7861.4 8233.5 8254.8 8279.6 9018.6 9076.0 9092.2 9097.5 9101.0 7084.8 7202.7 7267.5 7271.8 7536.5 7933.9 8038.4 8049.2 8087.3 8122.1 7556.5 7673.4 7680.6 7689.8 7696.7 5501.3 5604.4 5648.6 5674.9 5679.1 5523.9 5526.9 5622.6 5666.4 5694.5 16:36:19 INFO - PROCESS | 19461 | 16:36:19 INFO - PROCESS | 19461 | [#4] prototype.html Cycles:180 Average:5062.10 Median:5747.13 stddev:1477.55 (25.7%) stddev-sans-first:1438.65 16:36:19 INFO - PROCESS | 19461 | Values: 344.9 346.9 354.1 354.6 358.0 5737.6 5750.5 5765.3 5781.0 5789.7 5673.6 5703.3 5706.3 5709.3 5721.5 4074.2 4426.0 4463.6 4468.4 4472.4 4457.8 4458.7 4461.4 4474.9 4477.2 4439.4 4440.8 4445.7 4450.8 4455.3 4296.6 4367.5 4439.0 4448.6 4458.9 3945.9 3952.9 3959.2 3971.3 3988.9 5536.9 5541.6 5556.6 5567.2 5585.4 5073.1 5114.0 5147.9 5150.0 5156.8 5921.3 5926.1 5945.3 5973.5 5983.0 4306.8 4372.8 4378.5 4380.7 4380.8 6151.2 6159.8 6227.3 6233.9 6264.4 4476.4 4493.5 4517.3 4519.8 4538.3 4426.9 4522.6 4575.6 4589.4 4590.9 5104.7 5145.6 5153.8 5158.5 5172.1 5962.0 6016.2 6038.9 6060.3 6063.8 1523.2 1566.7 1569.0 1576.2 1581.8 1000.8 1014.4 1017.1 1058.0 1098.8 5703.0 5725.7 5743.7 5763.2 5792.9 6033.9 6058.6 6078.6 6080.2 6083.3 5624.5 5704.3 5754.3 5779.6 5794.4 3230.6 3267.6 3269.2 3270.8 3275.2 6109.9 6312.0 6319.0 6320.3 6369.2 6211.3 6216.6 6227.6 6259.2 6261.0 6033.8 6281.0 6350.4 6369.5 6397.4 6009.4 6016.2 6016.8 6054.5 6087.6 5999.7 6008.5 6013.4 6048.2 6055.9 6216.7 6228.4 6452.5 6473.6 6476.7 4369.5 4434.4 4440.4 4451.1 4467.9 6135.5 6228.9 6259.8 6280.7 6299.3 6029.7 6047.7 6055.8 6058.4 6069.8 6013.5 6021.7 6023.3 6029.0 6036.0 5815.6 5864.2 5916.2 5932.4 5940.5 6017.6 6020.6 6094.8 6112.4 6115.6 5942.9 5950.3 5965.2 5967.8 5980.0 16:36:19 INFO - PROCESS | 19461 | 16:36:19 INFO - PROCESS | 19461 | [#5] yui.html Cycles:180 Average:21665.71 Median:3942.85 stddev:31051.24 (787.5%) stddev-sans-first:31098.76 16:36:19 INFO - PROCESS | 19461 | Values: 784.8 794.5 798.2 806.3 901.3 13787.4 14345.8 14429.1 14458.6 14517.3 13657.5 13749.5 13756.2 16005.9 16273.6 863.3 873.7 876.6 878.3 880.1 854.4 856.9 860.0 878.0 895.8 921.5 923.4 924.2 926.4 927.0 923.5 932.3 932.8 933.3 933.4 683.4 686.0 686.8 686.8 687.2 16508.6 16517.1 16533.5 16552.3 16621.1 14229.4 14632.6 14689.0 14717.5 14796.6 13393.5 13412.3 13559.6 13654.9 13735.8 3972.3 3977.2 3984.4 4003.6 4066.3 85768.6 86398.0 86592.0 86764.1 87336.6 12369.4 12413.3 12662.4 12810.9 12975.2 23438.5 23446.6 23482.9 23503.6 23690.5 9104.1 9220.4 9338.4 9402.3 9572.8 5404.7 5410.1 5431.4 5485.6 5510.2 3791.4 3849.1 3867.1 3877.2 3913.4 666.2 683.3 684.5 700.7 703.7 748.5 801.6 809.6 834.6 838.9 10017.1 10168.7 10277.3 10297.8 10333.2 634.9 720.8 746.4 758.7 766.4 4412.3 4457.9 4715.2 4741.1 5021.3 129881.4 131121.3 133792.3 134005.3 136546.0 65273.0 68721.3 69979.3 83258.6 91875.1 72799.3 96497.0 98281.0 98789.0 100125.0 10199.5 10497.0 10554.1 10644.5 10651.6 49000.3 57301.4 57596.7 57991.0 58532.4 49368.8 66580.7 71989.6 73945.4 76983.6 13980.9 14036.6 14906.5 14945.2 15027.1 15233.2 15370.1 16651.2 17301.8 18141.5 14815.0 15276.0 15298.2 15436.2 16359.5 14569.3 15144.4 15458.2 15519.6 15528.0 13657.2 14157.7 14344.2 14893.4 14909.6 11543.9 12690.1 12746.4 13048.3 13425.5 13142.5 13212.3 13218.1 13291.9 13345.5 16:36:19 INFO - PROCESS | 19461 | -------- Summary: end -------- 16:36:19 INFO - PROCESS | 19461 | 16:36:19 INFO - TEST-INFO | 19461: exit 0 16:36:19 INFO - TEST-OK | dromaeo_css | took 1110956ms 16:36:19 INFO - TEST-START | kraken 16:36:19 INFO - operating with platform_type : linux_ 16:36:19 INFO - Initialising browser for kraken test... 16:36:19 INFO - TEST-INFO | started process 19705 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjNPr07/profile http://localhost:59690/getInfo.html) 16:36:24 INFO - PROCESS | 19705 | __metrics Screen width/height:1600/1200 16:36:24 INFO - PROCESS | 19705 | colorDepth:24 16:36:24 INFO - PROCESS | 19705 | Browser inner width/height: 1024/697 16:36:24 INFO - PROCESS | 19705 | __metrics 16:36:24 ERROR - PROCESS | 19705 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 16:36:25 INFO - TEST-INFO | 19705: exit 0 16:36:25 INFO - Browser initialized. 16:36:25 INFO - Running cycle 1/1 for kraken test... 16:36:25 INFO - TEST-INFO | started process 19835 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjNPr07/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:36:37 INFO - PROCESS | 19835 | RSS: Main: 149852160 16:36:37 INFO - PROCESS | 19835 | 16:36:39 INFO - PROCESS | 19835 | Cycle 1(1): loaded http://localhost:59690/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59690/tests/kraken/driver.html?testName=audio-beat-detection) 16:36:40 INFO - PROCESS | 19835 | RSS: Main: 156323840 16:36:40 INFO - PROCESS | 19835 | 16:36:43 INFO - PROCESS | 19835 | Cycle 1(1): loaded http://localhost:59690/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59690/tests/kraken/driver.html?testName=audio-dft) 16:36:43 INFO - PROCESS | 19835 | RSS: Main: 155664384 16:36:43 INFO - PROCESS | 19835 | 16:36:46 INFO - PROCESS | 19835 | Cycle 1(1): loaded http://localhost:59690/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59690/tests/kraken/driver.html?testName=audio-fft) 16:36:47 INFO - PROCESS | 19835 | RSS: Main: 155811840 16:36:47 INFO - PROCESS | 19835 | 16:36:49 INFO - PROCESS | 19835 | Cycle 1(1): loaded http://localhost:59690/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59690/tests/kraken/driver.html?testName=audio-oscillator) 16:36:50 INFO - PROCESS | 19835 | RSS: Main: 155889664 16:36:50 INFO - PROCESS | 19835 | 16:36:52 INFO - PROCESS | 19835 | Cycle 1(1): loaded http://localhost:59690/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59690/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:36:53 INFO - PROCESS | 19835 | RSS: Main: 155447296 16:36:53 INFO - PROCESS | 19835 | 16:36:56 INFO - PROCESS | 19835 | Cycle 1(1): loaded http://localhost:59690/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59690/tests/kraken/driver.html?testName=imaging-darkroom) 16:36:56 INFO - PROCESS | 19835 | RSS: Main: 155693056 16:36:56 INFO - PROCESS | 19835 | 16:37:00 INFO - PROCESS | 19835 | Cycle 1(1): loaded http://localhost:59690/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59690/tests/kraken/driver.html?testName=imaging-desaturate) 16:37:00 INFO - PROCESS | 19835 | RSS: Main: 155971584 16:37:00 INFO - PROCESS | 19835 | 16:37:03 INFO - PROCESS | 19835 | Cycle 1(1): loaded http://localhost:59690/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59690/tests/kraken/driver.html?testName=json-parse-financial) 16:37:04 INFO - PROCESS | 19835 | RSS: Main: 156020736 16:37:04 INFO - PROCESS | 19835 | 16:37:05 INFO - PROCESS | 19835 | Cycle 1(1): loaded http://localhost:59690/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59690/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:37:06 INFO - PROCESS | 19835 | RSS: Main: 155082752 16:37:06 INFO - PROCESS | 19835 | 16:37:08 INFO - PROCESS | 19835 | Cycle 1(1): loaded http://localhost:59690/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59690/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:37:08 INFO - PROCESS | 19835 | RSS: Main: 155299840 16:37:08 INFO - PROCESS | 19835 | 16:37:10 INFO - PROCESS | 19835 | Cycle 1(1): loaded http://localhost:59690/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59690/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:37:11 INFO - PROCESS | 19835 | RSS: Main: 155877376 16:37:11 INFO - PROCESS | 19835 | 16:37:13 INFO - PROCESS | 19835 | Cycle 1(1): loaded http://localhost:59690/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59690/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:37:14 INFO - PROCESS | 19835 | RSS: Main: 156229632 16:37:14 INFO - PROCESS | 19835 | 16:37:17 INFO - PROCESS | 19835 | Cycle 1(1): loaded http://localhost:59690/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59690/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:37:17 INFO - PROCESS | 19835 | RSS: Main: 155967488 16:37:17 INFO - PROCESS | 19835 | 16:37:19 INFO - PROCESS | 19835 | Cycle 1(1): loaded http://localhost:59690/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59690/tests/kraken/driver.html?testName=ai-astar) 16:37:19 INFO - PROCESS | 19835 | RSS: Main: 157921280 16:37:19 INFO - PROCESS | 19835 | 16:37:19 INFO - PROCESS | 19835 | __start_tp_report 16:37:19 INFO - PROCESS | 19835 | _x_x_mozilla_page_load 16:37:19 INFO - PROCESS | 19835 | _x_x_mozilla_page_load_details 16:37:19 INFO - PROCESS | 19835 | |i|pagename|runs| 16:37:19 INFO - PROCESS | 19835 | |0;ai-astar;101;110;107;110;113;113;111;111;110;110 16:37:19 INFO - PROCESS | 19835 | |1;audio-beat-detection;142;116;141;169;124;142;145;118;170;118 16:37:19 INFO - PROCESS | 19835 | |2;audio-dft;167;164;164;163;163;162;168;168;164;163 16:37:19 INFO - PROCESS | 19835 | |3;audio-fft;77;75;75;178;76;75;75;77;169;77 16:37:19 INFO - PROCESS | 19835 | |4;audio-oscillator;85;83;157;84;85;84;139;85;84;141 16:37:19 INFO - PROCESS | 19835 | |5;imaging-gaussian-blur;117;117;118;118;118;118;121;117;118;119 16:37:19 INFO - PROCESS | 19835 | |6;imaging-darkroom;147;146;146;147;146;146;146;146;147;146 16:37:19 INFO - PROCESS | 19835 | |7;imaging-desaturate;95;94;99;100;95;97;95;95;95;96 16:37:19 INFO - PROCESS | 19835 | |8;json-parse-financial;55;55;52;54;52;54;55;52;53;53 16:37:19 INFO - PROCESS | 19835 | |9;json-stringify-tinderbox;64;59;59;60;60;60;60;62;63;61 16:37:19 INFO - PROCESS | 19835 | |10;stanford-crypto-aes;73;73;73;74;73;74;81;73;74;79 16:37:19 INFO - PROCESS | 19835 | |11;stanford-crypto-ccm;119;118;124;118;117;129;128;120;149;119 16:37:19 INFO - PROCESS | 19835 | |12;stanford-crypto-pbkdf2;153;153;152;155;161;155;152;155;154;155 16:37:19 INFO - PROCESS | 19835 | |13;stanford-crypto-sha256-iterative;67;62;61;64;64;61;60;60;61;61 16:37:19 INFO - PROCESS | 19835 | __end_tp_report 16:37:19 INFO - PROCESS | 19835 | __start_cc_report 16:37:19 INFO - PROCESS | 19835 | _x_x_mozilla_cycle_collect,872 16:37:19 INFO - PROCESS | 19835 | __end_cc_report 16:37:19 INFO - PROCESS | 19835 | __startTimestamp1476142639650__endTimestamp 16:37:19 INFO - PROCESS | 19835 | 16:37:19 INFO - PROCESS | 19835 | ------- Summary: start ------- 16:37:19 INFO - PROCESS | 19835 | Number of tests: 14 16:37:19 INFO - PROCESS | 19835 | 16:37:19 INFO - PROCESS | 19835 | [#0] ai-astar Cycles:10 Average:109.60 Median:110.50 stddev:3.47 (3.1%) stddev-sans-first:1.81 16:37:19 INFO - PROCESS | 19835 | Values: 101.0 110.0 107.0 110.0 113.0 113.0 111.0 111.0 110.0 110.0 16:37:19 INFO - PROCESS | 19835 | 16:37:19 INFO - PROCESS | 19835 | [#1] audio-beat-detection Cycles:10 Average:138.50 Median:142.00 stddev:19.87 (14.0%) stddev-sans-first:21.03 16:37:19 INFO - PROCESS | 19835 | Values: 142.0 116.0 141.0 169.0 124.0 142.0 145.0 118.0 170.0 118.0 16:37:19 INFO - PROCESS | 19835 | 16:37:19 INFO - PROCESS | 19835 | [#2] audio-dft Cycles:10 Average:164.60 Median:164.00 stddev:2.22 (1.4%) stddev-sans-first:2.18 16:37:19 INFO - PROCESS | 19835 | Values: 167.0 164.0 164.0 163.0 163.0 162.0 168.0 168.0 164.0 163.0 16:37:19 INFO - PROCESS | 19835 | 16:37:19 INFO - PROCESS | 19835 | [#3] audio-fft Cycles:10 Average:95.40 Median:75.50 stddev:41.23 (54.6%) stddev-sans-first:43.19 16:37:19 INFO - PROCESS | 19835 | Values: 77.0 75.0 75.0 178.0 76.0 75.0 75.0 77.0 169.0 77.0 16:37:19 INFO - PROCESS | 19835 | 16:37:19 INFO - PROCESS | 19835 | [#4] audio-oscillator Cycles:10 Average:102.70 Median:84.00 stddev:30.02 (35.7%) stddev-sans-first:31.15 16:37:19 INFO - PROCESS | 19835 | Values: 85.0 83.0 157.0 84.0 85.0 84.0 139.0 85.0 84.0 141.0 16:37:19 INFO - PROCESS | 19835 | 16:37:19 INFO - PROCESS | 19835 | [#5] imaging-gaussian-blur Cycles:10 Average:118.10 Median:118.00 stddev:1.20 (1.0%) stddev-sans-first:1.20 16:37:19 INFO - PROCESS | 19835 | Values: 117.0 117.0 118.0 118.0 118.0 118.0 121.0 117.0 118.0 119.0 16:37:19 INFO - PROCESS | 19835 | 16:37:19 INFO - PROCESS | 19835 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 16:37:19 INFO - PROCESS | 19835 | Values: 147.0 146.0 146.0 147.0 146.0 146.0 146.0 146.0 147.0 146.0 16:37:19 INFO - PROCESS | 19835 | 16:37:19 INFO - PROCESS | 19835 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:95.00 stddev:1.97 (2.1%) stddev-sans-first:2.05 16:37:19 INFO - PROCESS | 19835 | Values: 95.0 94.0 99.0 100.0 95.0 97.0 95.0 95.0 95.0 96.0 16:37:19 INFO - PROCESS | 19835 | 16:37:19 INFO - PROCESS | 19835 | [#8] json-parse-financial Cycles:10 Average:53.50 Median:54.00 stddev:1.27 (2.4%) stddev-sans-first:1.22 16:37:19 INFO - PROCESS | 19835 | Values: 55.0 55.0 52.0 54.0 52.0 54.0 55.0 52.0 53.0 53.0 16:37:19 INFO - PROCESS | 19835 | 16:37:19 INFO - PROCESS | 19835 | [#9] json-stringify-tinderbox Cycles:10 Average:60.80 Median:60.50 stddev:1.69 (2.8%) stddev-sans-first:1.33 16:37:19 INFO - PROCESS | 19835 | Values: 64.0 59.0 59.0 60.0 60.0 60.0 60.0 62.0 63.0 61.0 16:37:19 INFO - PROCESS | 19835 | 16:37:19 INFO - PROCESS | 19835 | [#10] stanford-crypto-aes Cycles:10 Average:74.70 Median:74.00 stddev:2.87 (3.9%) stddev-sans-first:2.98 16:37:19 INFO - PROCESS | 19835 | Values: 73.0 73.0 73.0 74.0 73.0 74.0 81.0 73.0 74.0 79.0 16:37:19 INFO - PROCESS | 19835 | 16:37:19 INFO - PROCESS | 19835 | [#11] stanford-crypto-ccm Cycles:10 Average:124.10 Median:122.00 stddev:9.73 (8.0%) stddev-sans-first:10.15 16:37:19 INFO - PROCESS | 19835 | Values: 119.0 118.0 124.0 118.0 117.0 129.0 128.0 120.0 149.0 119.0 16:37:19 INFO - PROCESS | 19835 | 16:37:19 INFO - PROCESS | 19835 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.50 Median:155.00 stddev:2.59 (1.7%) stddev-sans-first:2.69 16:37:19 INFO - PROCESS | 19835 | Values: 153.0 153.0 152.0 155.0 161.0 155.0 152.0 155.0 154.0 155.0 16:37:19 INFO - PROCESS | 19835 | 16:37:19 INFO - PROCESS | 19835 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.10 Median:61.50 stddev:2.23 (3.6%) stddev-sans-first:1.51 16:37:19 INFO - PROCESS | 19835 | Values: 67.0 62.0 61.0 64.0 64.0 61.0 60.0 60.0 61.0 61.0 16:37:19 INFO - PROCESS | 19835 | -------- Summary: end -------- 16:37:19 INFO - PROCESS | 19835 | 16:37:20 INFO - TEST-INFO | 19835: exit 0 16:37:20 INFO - TEST-OK | kraken | took 60837ms 16:37:20 INFO - SUITE-END | took 1171s 16:37:20 INFO - Completed test suite (00:19:32) 16:37:20 INFO - javascript benchmark 16:37:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7687.369235628002, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3277.0496555998757, 3296.1924328539503, 3296.1924328539512, 3314.651961544036, 3333.7833040852342, 5652.09566469365, 5669.09294512878, 5671.886562268752, 5674.914876276859, 5676.631018983769, 5655.971720141393, 5719.027765279902, 5719.628224165426, 5728.742206600703, 5732.455416735404, 5183.248428977796, 5198.714070726109, 5216.400113986883, 5258.44786297439, 5277.366715994067, 5256.0, 5276.393214780292, 5276.551493123089, 5283.022640811462, 5301.257823904637, 5076.162433198518, 5090.134677104883, 5263.736813159346, 5269.341332333458, 5276.366835979668, 5092.108880945838, 5102.438731739506, 5131.435542090367, 5205.739713014372, 5206.062908676437, 5077.390713114413, 5163.277141200198, 5173.9741301293625, 5174.197999310113, 5213.687178769286, 5506.807261745819, 5590.8043218487155, 5599.7480113394995, 5644.266245388114, 5690.146478028288, 5913.05391137416, 5945.970270148665, 5978.342382337939, 6040.939590604125, 6051.062085376773, 6024.09638554216, 6046.093086037085, 6050.788222412194, 6057.848553786146, 6092.908606370908, 5448.618596698193, 5662.886742265132, 5666.405027472098, 5670.0360938640115, 5672.12082127271, 6032.065029920369, 6061.424164704435, 6067.484263837535, 6129.664444256096, 6130.031268545464, 5826.359100498942, 5875.001249787546, 5885.882282354329, 5889.38161493037, 5903.527717782567, 5907.1434641976675, 5933.0, 5977.342492325841, 5980.700964951822, 5987.730552125165, 5975.970120149458, 5997.790077347359, 6026.216591843032, 6095.634261944298, 6136.6624835633575, 6069.726862291208, 6086.239220097488, 6094.177286066413, 6099.664518451527, 6110.083487476914, 4561.954380456219, 4692.741899195509, 4697.177993851131, 4698.036902434993, 4709.835155769531, 4106.568810274938, 4108.301588729923, 4154.086101057763, 4182.9581704182565, 4209.579042095827, 5789.044807606782, 5852.502537284378, 5858.209141765807, 5860.091685788624, 5861.296644402613, 5932.940670593325, 6128.724207410677, 6141.048137538689, 6142.170806941095, 6143.84640383994, 5628.493435590734, 5704.629199102128, 5709.457601527848, 5741.1388291756575, 5741.712914354265, 4946.060248552835, 4991.4758950310425, 5018.573421259161, 5019.14674505335, 5027.522385373383, 5954.85112872173, 6031.276246850406, 6051.939480605138, 6072.848178795565, 6095.0, 5911.083782013795, 5988.341282458839, 6006.789762358297, 6011.6693581853415, 6013.849653758691, 6188.133661287513, 6220.409061139185, 6252.812415627538, 6264.31092579825, 6265.655388953469, 5849.590528663123, 5862.267216597926, 5906.645601263938, 5937.554683398676, 5953.28560572734, 5931.258592675916, 6019.6990150493175, 6025.216721826135, 6058.909116363347, 6063.211782468251, 5764.913526297025, 5842.970785146047, 5849.239598852122, 5853.765849366148, 5881.206037184926, 5516.889662206813, 5810.564207684356, 5820.214271073521, 5822.796202132905, 5824.475797178275, 5775.364709881826, 5881.588288819913, 5885.0, 5901.350851406256, 5937.8218653438735, 5853.35613082552, 5911.083782013795, 5945.167676525376, 5971.58198926071, 5989.0, 5644.491995720405, 5670.206171135962, 5815.912761308668, 5825.592208545361, 5839.124131380327], "value": 5561.255784968567, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [585.8857522783056, 633.471051671854, 643.1767337807606, 645.6578013652763, 655.7868692674882, 33840.66159338406, 45897.31154032688, 47025.29462058072, 47102.764486177606, 47233.763831180884, 48170.75914620422, 48722.75638621802, 48901.51098489014, 48980.26529602059, 49068.754656226665, 9337.0, 9481.62073517062, 9499.667511637093, 9501.80996380072, 9510.524473776319, 9318.76703082425, 9353.67262145825, 9387.906120938806, 9390.389624674408, 9404.106609872051, 9353.67262145825, 9420.670276540322, 9442.291828112884, 9447.0, 9482.857757133648, 9352.719418417459, 9392.24862011041, 9406.2945279104, 9406.811863762687, 9415.058494150599, 9334.813303733956, 9345.485998270093, 9372.015938326445, 9390.577424015935, 9394.62421503139, 44367.0, 44400.555994439965, 44529.33206001913, 44662.10675786466, 44913.77543112264, 4031.516218053823, 4331.7617531035785, 4580.221362368372, 4659.138059459011, 4675.135100006476, 34711.479327810106, 35084.473732894025, 35374.115647108774, 35495.64504354949, 36692.44961325582, 4692.671512994092, 4734.763261836894, 4735.550122738335, 4740.2889566564945, 4808.0, 368097.0, 368955.0, 369234.0, 370586.0, 372631.0, 61947.38052619506, 62418.375816242165, 62603.0, 62609.68695156586, 62718.0, 39290.214195715926, 39779.80110099431, 40024.59975400209, 42139.57860421418, 42428.0, 19368.225270989285, 19615.901920490305, 19656.90171549162, 19663.311784087487, 19679.0, 12956.157849739737, 13081.084324097412, 13087.083904126619, 13115.950723942062, 13148.211107333591, 20535.0, 20795.480112997295, 20943.581128377653, 20971.26600568973, 21066.36800895945, 7530.359919406802, 7585.431092667962, 7623.123340815877, 7798.883016754639, 7802.336801371947, 1049.454283772434, 1072.8605281313535, 1107.2747350485445, 1144.6623246142408, 1146.4095990564865, 34109.65890341065, 34212.65787342144, 34264.0, 34448.0, 34616.48075278873, 1150.551284998851, 1161.8257261410688, 1180.3390101543164, 1211.7697637448857, 1261.9242845429303, 17379.217935192948, 17851.875027935395, 17982.550436238937, 18053.909730451527, 18134.09329533518, 590291.0, 594218.0, 600491.0, 600496.0, 602541.0, 63844.680776596746, 64428.35571644317, 64610.67694661496, 64650.676746615965, 64798.352016479235, 1428.5784513737842, 1459.3360021190333, 1471.9926400367929, 1472.8306244781772, 1481.1335368809152, 33031.83484082564, 33409.0, 33733.3253334927, 33733.66266337403, 34417.48373774345, 59700.0, 62320.68839655773, 62349.0, 67716.6614166926, 67988.6600566994, 554301.0, 558642.0, 558953.0, 558997.0, 559097.0, 48354.0, 48966.75516622394, 48976.0, 49136.50863491462, 49912.75043624759, 52668.47331526789, 52867.0, 52883.735581321846, 53734.0, 54307.0, 44679.32981005222, 45872.54127458682, 46510.53489465062, 47035.529644703114, 47357.76321118372, 44633.33050004188, 45778.54221457876, 46099.0, 46641.300380495, 46732.53267467282, 44707.552924470336, 44850.775746121064, 45552.08895822131, 45646.0, 46099.539004610866, 38307.0, 39508.40737388999, 39933.8643327779, 40007.39988900227, 40536.59463405328, 30014.699853002065, 30364.544531832482, 30702.0, 30954.69045309518, 30962.22594435067], "value": 22016.810593854985, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [408.75474715170884, 410.4827916824802, 421.275406301162, 428.60568277184996, 430.51782004155353, 19511.219551217953, 20711.446641501872, 21265.14939402424, 22234.332970010884, 22396.440088997784, 20343.389698309038, 20605.1757929683, 20627.27804526842, 20950.895245523752, 21173.364799056053, 5943.88112237755, 6119.571629985903, 6145.477634401082, 6146.692665366736, 6154.969225153868, 5317.574594032488, 5571.8607034824045, 5617.185508101323, 6029.457348838604, 6055.122007308938, 5524.254225679522, 5682.914756278659, 5708.200851880719, 5709.571782116337, 5711.228984087157, 5792.565557583177, 5925.8814823703715, 5928.3775203603645, 5937.22816033915, 5953.196318496991, 4916.1888288432365, 5161.896762064775, 5177.870553236162, 5217.947820521822, 5225.686458812484, 13377.73244535104, 14964.0, 23616.52766944669, 24373.26880193597, 24724.25827225186, 2360.7875291223872, 2362.6692263083182, 2586.2241327601832, 2964.673885872552, 3009.623797025372, 9987.450690212036, 10016.348937319051, 10222.9488852556, 10249.282550221487, 14708.926455367655, 1891.1017266798299, 1956.3935180094215, 1971.2607772085469, 1972.1224055295256, 1982.3260091568936, 84166.57916710438, 85942.0, 87028.56485717594, 87803.56098219533, 91043.0, 11043.392613406178, 11196.104311655212, 11254.15593830466, 11318.886811131948, 11733.589324373606, 16396.83603163977, 16439.91780041092, 16440.917795411187, 16468.341266349453, 16541.338346466247, 8237.50574965504, 8308.667653293922, 8349.206825351583, 8536.573171341408, 8548.102449242864, 7998.440109192301, 8021.799455013671, 8170.591470426455, 8189.22202390772, 8253.257206851293, 4940.061388336277, 4973.5523802857915, 5050.393952725696, 5090.898182036339, 5179.482051794866, 2081.7621057363394, 2088.6762551804495, 2093.13135048956, 2138.7219661443914, 2162.7296587926508, 941.5292353823088, 1014.6702321745462, 1084.8481212630238, 1095.7370231144469, 1108.6396921000708, 19458.902705486384, 20748.48128796762, 21289.254876079263, 21376.679349809765, 21589.78410215909, 1021.8569400283966, 1027.5324727249083, 1031.1493018259816, 1039.111559616532, 1066.7119877632995, 11511.136664750176, 11598.0, 11737.178397512092, 11852.0, 11913.940430297793, 519752.0, 521429.0, 533320.0, 536447.0, 546864.0, 95476.0, 98500.50749746205, 100091.0, 101522.49238753758, 101552.49223753835, 1049.2655141401049, 1058.4972138234277, 1060.6605886116522, 1066.328213225663, 1088.5482524752297, 18127.36554220596, 18398.448046558624, 18687.159077841803, 18907.177990994718, 18996.050197490345, 42485.57514424816, 43754.78122609366, 44966.325505118104, 45963.0, 46355.999999998654, 57657.711711441174, 57745.0, 62544.0, 64524.35475645184, 65287.347126528126, 8116.75649730509, 8775.385722999328, 9048.547572621474, 9240.029796871231, 9274.072592740671, 13494.52769153075, 13583.79624305656, 13865.168089914638, 14445.0, 14475.420983160555, 11965.0, 11970.401479925795, 12576.245425274512, 12641.93679031599, 13093.0, 12160.331181785086, 12375.133740638068, 12502.562410315595, 12729.29988850622, 12965.091687193726, 11481.655550333504, 11655.41722913834, 12468.376581171087, 12616.810747838974, 12969.092163548838, 8050.114487406264, 8152.2662960333855, 8219.671213151407, 8223.794405139919, 8366.0, 9989.800203996025, 12363.134580579273, 12368.381580921097, 12544.0, 12612.810807837706], "value": 9646.43869611323, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1510.6072421170493, 1523.0709267346917, 1665.0758828849982, 1806.8644851636132, 1820.217306558181, 8701.0, 9029.097090290968, 9301.95349023254, 9346.158845703885, 9438.292128090403, 9083.682071127512, 9202.677906273282, 9224.907750922488, 9262.444253344804, 9290.489023103726, 2278.7949084582424, 2339.894704738291, 2349.835511514195, 2351.9647205291935, 2352.7882490575844, 2260.785225403584, 2296.9310920672324, 2371.6679664846934, 2372.54921564903, 2375.786179243876, 2337.532493501298, 2342.367560758594, 2345.554344674515, 2346.894389752457, 2360.4570948681812, 2317.6639387288833, 2319.246244970391, 2338.7661233876647, 2342.355852140658, 2343.320437073247, 2320.7447180810095, 2320.8375413721046, 2324.2213858357472, 2328.6507023946374, 2336.953260934789, 9129.0, 9191.862122068174, 9209.907900920973, 9216.262698984065, 9228.077192280785, 5316.9734151329385, 5386.91919621206, 5467.0705979983495, 5529.391766905637, 5533.170024496358, 3450.9992102290307, 3487.668671476206, 3515.0860776198115, 3581.713462922986, 3604.080959355374, 1102.1348241630283, 1116.4696769034645, 1122.5004872831594, 1139.6011396011413, 1144.7824913266536, 12456.75086498274, 12549.247045177228, 12553.246805191719, 12576.81134782979, 12610.81083783744, 4461.442319710036, 4518.548145185455, 4631.58315751584, 4633.050224703928, 4657.69724967876, 10064.295499314978, 10065.094141527297, 10067.244956628136, 10076.69769906904, 10083.14293285079, 5343.118385466354, 5345.86635334112, 5363.249145119687, 5377.704226267593, 5386.13821788512, 4948.579370753526, 5044.9495505045215, 5098.694078355311, 5135.6405051646025, 5189.065968125774, 3724.5530536335814, 3808.5429748430365, 3857.3056849767313, 3873.6126387361037, 3883.0874744435037, 1125.21797350842, 1129.2603344809163, 1132.4960392625203, 1142.0920368307216, 1151.1423989127986, 1014.802113587858, 1044.9738756530996, 1062.7077553672648, 1064.7817197474499, 1077.5689724110418, 6069.02895536712, 6157.507399408037, 6183.5671502994355, 6244.344343843922, 6247.625142491465, 478.6147151542972, 488.1359992812702, 500.4161827814925, 506.2684421011603, 507.5127877237819, 4449.421575195269, 4544.545545445429, 4564.360989461478, 4607.953920460753, 4645.094206629675, 10824.891751082389, 11327.60353387644, 11338.206325557132, 11341.319520828776, 11360.659180224606, 10623.415712135753, 11118.666440006651, 11297.0, 11323.830142547868, 11343.149263805248, 8434.15658434164, 8595.5702214889, 8640.567971601395, 8647.827043459096, 8654.264387527004, 6138.263408391022, 6285.214348206474, 6292.867283888944, 6427.389398007182, 6548.410643042149, 10459.529321180717, 10468.738281543023, 10570.577176913144, 10647.467626618483, 10728.409937453514, 10041.648542300984, 10341.896581034394, 10679.359238445719, 10843.45782710877, 10843.620473283398, 7839.216078392344, 7861.371090312647, 8233.50598964064, 8254.752357429286, 8279.62741676638, 9018.5941632628, 9075.954620226856, 9092.181703646704, 9097.454152750855, 9101.044390338919, 7084.752033678797, 7202.747903823551, 7267.454940879349, 7271.781846544613, 7536.472446928662, 7933.920660793318, 8038.39712021589, 8049.154838741848, 8087.3125784308995, 8122.065962414398, 7556.546607203585, 7673.424493162924, 7680.577568233801, 7689.8462030757955, 7696.7306144284685, 5501.257330260363, 5604.355499117653, 5648.57635677334, 5674.886502270014, 5679.148127780701, 5523.8895222096135, 5526.91709624364, 5622.634528755618, 5666.433356664301, 5694.515966142924], "value": 4698.904613036729, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [344.9327381160674, 346.9176367970582, 354.0928973130598, 354.6081579854261, 358.01902786365366, 5737.569682273831, 5750.511206547443, 5765.3369862465825, 5781.0, 5789.681567513785, 5673.574481913853, 5703.344115426717, 5706.258186435768, 5709.34429015585, 5721.485066344028, 4074.1851629674034, 4425.955740442602, 4463.642908567307, 4468.374427580141, 4472.44094488189, 4457.799399027035, 4458.732476051431, 4461.39771130898, 4474.865754027384, 4477.171723231197, 4439.400680908068, 4440.800163992628, 4445.711028783118, 4450.777461126947, 4455.331700244957, 4296.591823776736, 4367.54140815213, 4438.977805110986, 4448.57645553423, 4458.910821783546, 3945.9210815783813, 3952.920941581181, 3959.227950549644, 3971.344728119857, 3988.8631739953976, 5536.944630553683, 5541.556675465953, 5556.611037227396, 5567.248421463131, 5585.413531579207, 5073.097588404348, 5113.974430127825, 5147.871303217412, 5150.021495915801, 5156.793728250866, 5921.319048309457, 5926.140709597084, 5945.346011938684, 5973.492253158443, 5982.970085149546, 4306.849260275875, 4372.781360931941, 4378.452693413324, 4380.671449641258, 4380.824767009316, 6151.200343955302, 6159.81520554384, 6227.287495938653, 6233.877901977642, 6264.436200741955, 4476.37330773692, 4493.528179541101, 4517.277235642281, 4519.7740112994215, 4538.2738761797955, 4426.889327766831, 4522.592966632953, 4575.611073058827, 4589.426321709786, 4590.88522786933, 5104.668196567211, 5145.562627176732, 5153.845384638467, 5158.509941555546, 5172.112179054693, 5961.970190149108, 6016.187814644967, 6038.909416358758, 6060.33336333003, 6063.7574497020505, 1523.2155439948435, 1566.749320108777, 1568.9607759806097, 1576.2355257700005, 1581.841815818409, 1000.7540611938183, 1014.4116412480744, 1017.1252722658508, 1057.9682609521726, 1098.774751176007, 5702.971485142631, 5725.6850873202375, 5743.741531631086, 5763.221965034667, 5792.8551786204835, 6033.909491357633, 6058.57589968698, 6078.6048906820915, 6080.209572755602, 6083.300420451616, 5624.521915637135, 5704.258446402024, 5754.280714910637, 5779.566532509994, 5794.362620111784, 3230.5623997321436, 3267.5949341782784, 3269.150020994511, 3270.8201048942537, 3275.2139486523065, 6109.877802443926, 6311.990081586924, 6318.968405157945, 6320.273168585672, 6369.1847823371045, 6211.254649442096, 6216.595921265103, 6227.564070515111, 6259.2488901332135, 6260.998240281533, 6033.7586496540525, 6280.963640999275, 6350.412017210261, 6369.490440764727, 6397.392247736458, 6009.429104235091, 6016.157737916783, 6016.819495415145, 6054.485368743706, 6087.57386982907, 5999.720106359556, 6008.5493587981955, 6013.3685962975005, 6048.153258543719, 6055.878882422415, 6216.658083805434, 6228.418659270847, 6452.483801295979, 6473.611583305017, 6476.740930362733, 4369.497507786518, 4434.3791869138995, 4440.444944381952, 4451.065276291885, 4467.932981005222, 6135.539834512519, 6228.875422491434, 6259.843503912439, 6280.654563999024, 6299.307076221704, 6029.728662210299, 6047.697615119315, 6055.848603784941, 6058.4244496772735, 6069.757209711562, 6013.458788709037, 6021.729022194099, 6023.27720673522, 6029.0, 6035.969820150871, 5815.563832712479, 5864.208331875142, 5916.201312822714, 5932.377100404396, 5940.544566581042, 6017.638941663514, 6020.638761674313, 6094.8171554853425, 6112.410773199089, 6115.602485838406, 5942.910856337245, 5950.3339065061855, 5965.224520812267, 5967.8209653710455, 5980.0431930890845], "value": 4589.740311641381, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [784.8037990502378, 794.4994653368377, 798.2456578533286, 806.2904643913355, 901.3420203251626, 13787.448502059919, 14345.78481322781, 14429.062110962781, 14458.566243012714, 14517.346719397627, 13657.521986730466, 13749.450021999108, 13756.243406612657, 16005.919970400131, 16273.593160170973, 863.3136656358195, 873.6723728601775, 876.6055275126218, 878.323690758119, 880.0935036911991, 854.372036553133, 856.8500512410303, 859.9527026013567, 878.0253918150879, 895.8163576466841, 921.5392303848076, 923.4413180026088, 924.2282693950559, 926.3885835348672, 927.0451435021938, 923.487464457226, 932.305432452827, 932.7761337279038, 933.2533972821749, 933.3793027636614, 683.3883674111643, 685.9622720750357, 686.8111269400905, 686.8317262270775, 687.182253118787, 16508.587285317844, 16517.091559964196, 16533.50399488017, 16552.255148518227, 16621.085840278778, 14229.359678814375, 14632.561023169323, 14689.0, 14717.484888028976, 14796.556103316918, 13393.531226407127, 13412.26232557209, 13559.59321220365, 13654.863451365458, 13735.793963090562, 3972.324704800191, 3977.164795392971, 3984.4222587724907, 4003.5996400360023, 4066.3493840985598, 85768.57115714444, 86398.0, 86592.0, 86764.13235867687, 87336.56331718364, 12369.443375048144, 12413.255204687748, 12662.430190641444, 12810.9359453204, 12975.22148671064, 23438.531229375316, 23446.64830027551, 23482.88258558696, 23503.647445288334, 23690.526189476113, 9104.13510716494, 9220.354575179806, 9338.393004454689, 9402.294827887936, 9572.76068098303, 5404.729888476205, 5410.080286351251, 5431.429699881534, 5485.643433176911, 5510.201020851954, 3791.3933770597123, 3849.1147036181274, 3867.0525721198487, 3877.2051729395407, 3913.3738601824143, 666.1573110015834, 683.3474032299142, 684.5174152222671, 700.663681432915, 703.7044441334651, 748.5134662469329, 801.6152246921393, 809.6437567470412, 834.6202477872674, 838.9286910612666, 10017.148542373834, 10168.678071850612, 10277.280590358603, 10297.845532317022, 10333.22500812442, 634.946029587481, 720.8306048078697, 746.4177941205868, 758.7382353088176, 766.4404984361447, 4412.301264013314, 4457.910841783211, 4715.198416269242, 4741.146593613183, 5021.321164060703, 129881.35059324832, 131121.34439327742, 133792.33103834614, 134005.32997334952, 136546.0, 65273.0, 68721.3127868715, 69979.30020699727, 83258.58370708229, 91875.08124918799, 72799.2720072803, 96497.0, 98281.0, 98789.0, 100125.0, 10199.490025498844, 10497.016700480957, 10554.10290125348, 10644.467776611293, 10651.627193048205, 49000.26499602437, 57301.42698572961, 57596.71201643965, 57991.0, 58532.4146758527, 49368.75315623399, 66580.66709666421, 71989.6400517994, 73945.41438893463, 76983.61508192647, 13980.930095349458, 14036.649083772987, 14906.478273260384, 14945.178015209269, 15027.09837409759, 15233.23833808283, 15370.077795332316, 16651.167441628113, 17301.826981730526, 18141.537848804237, 14815.0, 15276.0, 15298.158601277037, 15436.151011694465, 16359.509214723577, 14569.271536422924, 15144.394224230908, 15458.227088645748, 15519.612009699847, 15528.0, 13657.248851313274, 14157.716845663235, 14344.211068390921, 14893.404263829325, 14909.552713418614, 11543.94228028888, 12690.11169218146, 12746.426410811351, 13048.347582620641, 13425.530106446227, 13142.540011099565, 13212.273324967218, 13218.140820846615, 13291.867081329063, 13345.466181352636], "value": 8101.079643387947, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1501.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 110.0, 107.0, 110.0, 113.0, 113.0, 111.0, 111.0, 110.0, 110.0], "value": 109.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 116.0, 141.0, 169.0, 124.0, 142.0, 145.0, 118.0, 170.0, 118.0], "value": 138.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 164.0, 164.0, 163.0, 163.0, 162.0, 168.0, 168.0, 164.0, 163.0], "value": 164.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 75.0, 178.0, 76.0, 75.0, 75.0, 77.0, 169.0, 77.0], "value": 95.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 157.0, 84.0, 85.0, 84.0, 139.0, 85.0, 84.0, 141.0], "value": 102.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 118.0, 118.0, 118.0, 121.0, 117.0, 118.0, 119.0], "value": 118.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 99.0, 100.0, 95.0, 97.0, 95.0, 95.0, 95.0, 96.0], "value": 96.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 52.0, 54.0, 52.0, 54.0, 55.0, 52.0, 53.0, 53.0], "value": 53.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 59.0, 59.0, 60.0, 60.0, 60.0, 60.0, 62.0, 63.0, 61.0], "value": 60.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 73.0, 74.0, 73.0, 74.0, 81.0, 73.0, 74.0, 79.0], "value": 74.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 118.0, 124.0, 118.0, 117.0, 129.0, 128.0, 120.0, 149.0, 119.0], "value": 124.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 153.0, 152.0, 155.0, 161.0, 155.0, 152.0, 155.0, 154.0, 155.0], "value": 154.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 62.0, 61.0, 64.0, 64.0, 61.0, 60.0, 60.0, 61.0, 61.0], "value": 62.1, "unit": "score"}]}]} 16:37:20 INFO - Return code: 0 16:37:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:37:20 ERROR - # TBPL SUCCESS # 16:37:20 INFO - Running post-action listener: _resource_record_post_action 16:37:20 INFO - [mozharness: 2016-10-10 23:37:20.949758Z] Finished run-tests step (success) 16:37:20 INFO - Running post-run listener: _resource_record_post_run 16:37:21 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 4096; Write bytes: 289316864; Read time: 16; Write time: 236980 16:37:21 INFO - TinderboxPrint: CPU usage
13.2% 16:37:21 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 16:37:21 INFO - TinderboxPrint: I/O write bytes / time
289,316,864 / 236,980 16:37:21 INFO - TinderboxPrint: CPU idle
8,217.6 (86.8%) 16:37:21 INFO - TinderboxPrint: CPU user
1,192.8 (12.6%) 16:37:21 INFO - TinderboxPrint: Swap in / out
0 / 0 16:37:21 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 71643136; Read time: 0; Write time: 78128 16:37:21 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 4096; Write bytes: 217673728; Read time: 16; Write time: 158852 16:37:21 INFO - Running post-run listener: _upload_blobber_files 16:37:21 INFO - Blob upload gear active. 16:37:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:37:21 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 16:37:21 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'] 16:37:21 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 16:37:21 INFO - (blobuploader) - INFO - Open directory for files ... 16:37:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:37:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:37:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:37:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:37:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:37:23 INFO - (blobuploader) - INFO - Done attempting. 16:37:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:37:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:37:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:37:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:37:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:37:23 INFO - (blobuploader) - INFO - Done attempting. 16:37:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:37:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:37:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:37:26 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:37:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:37:26 INFO - (blobuploader) - INFO - Done attempting. 16:37:26 INFO - (blobuploader) - INFO - Iteration through files over. 16:37:26 INFO - Return code: 0 16:37:26 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:37:26 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:37:26 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/80404b9c6707d35f3a11a6331a1445c4d9f6b0266cd234e3494fb3fc79e909082b73f5ca7285751ca5961dbe3564ec4238ee1fddbfd27970e0d5922fdf3d5803", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c936803442a034d77f4822fc64927719c915f31a5b8b9063e7b498b73c052d03ece73159d2b68a315f4ff0119f30881369d40a244467e66a09daf806d5d46440", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/72122e4aa14f8e98c59a3958209510d0a88eeb1abbd6a99dc522551c98786ab50d02c4e36aa0914aac5769852cf8bb984f4e5409f41536e1a63e62d515829501"} 16:37:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:37:26 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:37:26 INFO - Contents: 16:37:26 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/80404b9c6707d35f3a11a6331a1445c4d9f6b0266cd234e3494fb3fc79e909082b73f5ca7285751ca5961dbe3564ec4238ee1fddbfd27970e0d5922fdf3d5803", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c936803442a034d77f4822fc64927719c915f31a5b8b9063e7b498b73c052d03ece73159d2b68a315f4ff0119f30881369d40a244467e66a09daf806d5d46440", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/72122e4aa14f8e98c59a3958209510d0a88eeb1abbd6a99dc522551c98786ab50d02c4e36aa0914aac5769852cf8bb984f4e5409f41536e1a63e62d515829501"} 16:37:26 INFO - Running post-run listener: copy_logs_to_upload_dir 16:37:26 INFO - Copying logs to upload dir... 16:37:26 INFO - mkdir: /builds/slave/test/build/upload/logs 16:37:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1673.485564 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 53 secs) (at 2016-10-10 16:37:26.115487) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-10 16:37:26.119360) ========= 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=db7e7c15f3ca076d53731445000001ba-1476140971.709362-1299813503 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/80404b9c6707d35f3a11a6331a1445c4d9f6b0266cd234e3494fb3fc79e909082b73f5ca7285751ca5961dbe3564ec4238ee1fddbfd27970e0d5922fdf3d5803", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c936803442a034d77f4822fc64927719c915f31a5b8b9063e7b498b73c052d03ece73159d2b68a315f4ff0119f30881369d40a244467e66a09daf806d5d46440", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/72122e4aa14f8e98c59a3958209510d0a88eeb1abbd6a99dc522551c98786ab50d02c4e36aa0914aac5769852cf8bb984f4e5409f41536e1a63e62d515829501"} build_url:https://queue.taskcluster.net/v1/task/NcIysMkiS16GTAPmO-Y0Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011333 build_url: 'https://queue.taskcluster.net/v1/task/NcIysMkiS16GTAPmO-Y0Og/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/80404b9c6707d35f3a11a6331a1445c4d9f6b0266cd234e3494fb3fc79e909082b73f5ca7285751ca5961dbe3564ec4238ee1fddbfd27970e0d5922fdf3d5803", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c936803442a034d77f4822fc64927719c915f31a5b8b9063e7b498b73c052d03ece73159d2b68a315f4ff0119f30881369d40a244467e66a09daf806d5d46440", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/72122e4aa14f8e98c59a3958209510d0a88eeb1abbd6a99dc522551c98786ab50d02c4e36aa0914aac5769852cf8bb984f4e5409f41536e1a63e62d515829501"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-10 16:37:26.145291) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 16:37:26.145839) ========= 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=db7e7c15f3ca076d53731445000001ba-1476140971.709362-1299813503 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004501 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 16:37:26.228507) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-10 16:37:26.228960) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-10 16:37:26.229369) ========= ========= Total master_lag: 0.16 =========