builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-003 starttime: 1474941967.91 results: success (0) buildid: 20160926162149 builduid: ca8a8a22360b45da9ebe8e3971c4cf9e revision: 865939f4946d80fa532aaa168515a2fe69f9a774 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-26 19:06:07.910369) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-26 19:06:07.910862) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-26 19:06:07.911193) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-26 19:06:07.926001) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 19:06:07.926337) ========= 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=7de08804244eb36560b44971000001c3-1474941967.684827-1276825723 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-26 19:06:08-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.7M=0s 2016-09-26 19:06:08 (46.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.081412 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 19:06:08.022088) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 19:06:08.022466) ========= 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=7de08804244eb36560b44971000001c3-1474941967.684827-1276825723 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019667 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 19:06:08.072370) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 19:06:08.072779) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 865939f4946d80fa532aaa168515a2fe69f9a774 --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 865939f4946d80fa532aaa168515a2fe69f9a774 --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=7de08804244eb36560b44971000001c3-1474941967.684827-1276825723 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-26 19:06:08,576 truncating revision to first 12 chars 2016-09-26 19:06:08,576 Setting DEBUG logging. 2016-09-26 19:06:08,576 attempt 1/10 2016-09-26 19:06:08,576 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/865939f4946d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-26 19:06:08,884 unpacking tar archive at: mozilla-beta-865939f4946d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.683612 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 19:06:08.774072) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-26 19:06:08.774802) ========= script_repo_revision: 865939f4946d80fa532aaa168515a2fe69f9a774 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-26 19:06:08.775267) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-26 19:06:08.775574) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-26 19:06:08.786851) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 56 secs) (at 2016-09-26 19:06:08.787441) ========= /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=7de08804244eb36560b44971000001c3-1474941967.684827-1276825723 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:06:09 INFO - MultiFileLogger online at 20160926 19:06:09 in /builds/slave/test 19:06:09 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 19:06:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:06:09 INFO - {'append_to_log': False, 19:06:09 INFO - 'base_work_dir': '/builds/slave/test', 19:06:09 INFO - 'blob_upload_branch': 'Mozilla-Beta', 19:06:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:06:09 INFO - 'branch': 'Mozilla-Beta', 19:06:09 INFO - 'buildbot_json_path': 'buildprops.json', 19:06:09 INFO - 'config_files': ('talos/linux_config.py',), 19:06:09 INFO - 'default_actions': ('clobber', 19:06:09 INFO - 'read-buildbot-config', 19:06:09 INFO - 'download-and-extract', 19:06:09 INFO - 'populate-webroot', 19:06:09 INFO - 'create-virtualenv', 19:06:09 INFO - 'install', 19:06:09 INFO - 'run-tests'), 19:06:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:06:09 INFO - 'download_minidump_stackwalk': True, 19:06:09 INFO - 'download_symbols': 'ondemand', 19:06:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:06:09 INFO - 'tooltool.py': '/tools/tooltool.py', 19:06:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:06:09 INFO - '/tools/misc-python/virtualenv.py')}, 19:06:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:06:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:06:09 INFO - 'installer_path': 'installer.exe', 19:06:09 INFO - 'log_level': 'info', 19:06:09 INFO - 'log_name': 'talos', 19:06:09 INFO - 'log_to_console': True, 19:06:09 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:06:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:06:09 INFO - 'opt_config_files': (), 19:06:09 INFO - 'pip_index': False, 19:06:09 INFO - 'sps_profile': False, 19:06:09 INFO - 'sps_profile_interval': 0, 19:06:09 INFO - 'suite': 'dromaeojs-e10s', 19:06:09 INFO - 'system_bits': '32', 19:06:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:06:09 INFO - 'title': 'talos-linux64-ix-003', 19:06:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:06:09 INFO - 'use_talos_json': True, 19:06:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:06:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:06:09 INFO - 'work_dir': 'build'} 19:06:09 INFO - [mozharness: 2016-09-27 02:06:09.382800Z] Running clobber step. 19:06:09 INFO - Running pre-action listener: _resource_record_pre_action 19:06:09 INFO - Running main action method: clobber 19:06:09 INFO - rmtree: /builds/slave/test/build 19:06:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:06:09 INFO - Running post-action listener: _resource_record_post_action 19:06:09 INFO - [mozharness: 2016-09-27 02:06:09.904412Z] Finished clobber step (success) 19:06:09 INFO - [mozharness: 2016-09-27 02:06:09.904514Z] Running read-buildbot-config step. 19:06:09 INFO - Running pre-action listener: _resource_record_pre_action 19:06:09 INFO - Running main action method: read_buildbot_config 19:06:09 INFO - Using buildbot properties: 19:06:09 INFO - { 19:06:09 INFO - "project": "", 19:06:09 INFO - "product": "firefox", 19:06:09 INFO - "script_repo_revision": "production", 19:06:09 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 19:06:09 INFO - "repository": "", 19:06:09 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 19:06:09 INFO - "buildid": "20160926162149", 19:06:09 INFO - "pgo_build": "True", 19:06:09 INFO - "basedir": "/builds/slave/test", 19:06:09 INFO - "buildnumber": 183, 19:06:09 INFO - "slavename": "talos-linux64-ix-003", 19:06:09 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 19:06:09 INFO - "platform": "ubuntu64_hw", 19:06:09 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 19:06:09 INFO - "branch": "mozilla-beta", 19:06:09 INFO - "repo_path": "releases/mozilla-beta", 19:06:09 INFO - "revision": "865939f4946d80fa532aaa168515a2fe69f9a774", 19:06:09 INFO - "stage_platform": "linux64-pgo", 19:06:09 INFO - "builduid": "ca8a8a22360b45da9ebe8e3971c4cf9e", 19:06:09 INFO - "slavebuilddir": "test" 19:06:09 INFO - } 19:06:09 INFO - Found installer url https://queue.taskcluster.net/v1/task/EDdfTcNgRSuWsa_XIhnz0A/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2. 19:06:09 INFO - Running post-action listener: _resource_record_post_action 19:06:09 INFO - [mozharness: 2016-09-27 02:06:09.906953Z] Finished read-buildbot-config step (success) 19:06:09 INFO - [mozharness: 2016-09-27 02:06:09.907043Z] Running download-and-extract step. 19:06:09 INFO - Running pre-action listener: _resource_record_pre_action 19:06:09 INFO - Running main action method: download_and_extract 19:06:09 INFO - mkdir: /builds/slave/test/build/tests 19:06: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')]} 19:06:09 INFO - https://queue.taskcluster.net/v1/task/EDdfTcNgRSuWsa_XIhnz0A/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 19:06:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EDdfTcNgRSuWsa_XIhnz0A/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 19:06:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EDdfTcNgRSuWsa_XIhnz0A/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 19:06:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EDdfTcNgRSuWsa_XIhnz0A/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 19:06:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EDdfTcNgRSuWsa_XIhnz0A/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 19:06:09 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EDdfTcNgRSuWsa_XIhnz0A/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 19:06:09 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 19:06:09 INFO - retry: Failed, sleeping 30 seconds before retrying 19:06:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EDdfTcNgRSuWsa_XIhnz0A/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 19:06:39 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EDdfTcNgRSuWsa_XIhnz0A/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 19:06:39 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 19:06:39 INFO - retry: Failed, sleeping 60 seconds before retrying 19:07:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EDdfTcNgRSuWsa_XIhnz0A/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 19:07:40 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EDdfTcNgRSuWsa_XIhnz0A/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 19:07:40 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 19:07:40 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EDdfTcNgRSuWsa_XIhnz0A/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! 19:07:40 INFO - Caught exception: HTTP Error 404: Not Found 19:07:40 INFO - Caught exception: HTTP Error 404: Not Found 19:07:40 INFO - Caught exception: HTTP Error 404: Not Found 19:07:40 INFO - trying https://queue.taskcluster.net/v1/task/EDdfTcNgRSuWsa_XIhnz0A/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 19:07:40 INFO - Downloading https://queue.taskcluster.net/v1/task/EDdfTcNgRSuWsa_XIhnz0A/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 19:07:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EDdfTcNgRSuWsa_XIhnz0A/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 19:07:40 INFO - Downloaded 1327 bytes. 19:07:40 INFO - Reading from file /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 19:07:40 INFO - Using the following test package requirements: 19:07:40 INFO - {u'common': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'], 19:07:40 INFO - u'cppunittest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 19:07:40 INFO - u'firefox-50.0.en-US.linux-x86_64.cppunittest.tests.zip'], 19:07:40 INFO - u'gtest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 19:07:40 INFO - u'firefox-50.0.en-US.linux-x86_64.gtest.tests.zip'], 19:07:40 INFO - u'jittest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 19:07:40 INFO - u'jsshell-linux-x86_64.zip'], 19:07:40 INFO - u'mochitest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 19:07:40 INFO - u'firefox-50.0.en-US.linux-x86_64.mochitest.tests.zip'], 19:07:40 INFO - u'mozbase': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'], 19:07:40 INFO - u'reftest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 19:07:40 INFO - u'firefox-50.0.en-US.linux-x86_64.reftest.tests.zip'], 19:07:40 INFO - u'talos': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 19:07:40 INFO - u'firefox-50.0.en-US.linux-x86_64.talos.tests.zip'], 19:07:40 INFO - u'web-platform': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 19:07:40 INFO - u'firefox-50.0.en-US.linux-x86_64.web-platform.tests.zip'], 19:07:40 INFO - u'xpcshell': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 19:07:40 INFO - u'firefox-50.0.en-US.linux-x86_64.xpcshell.tests.zip']} 19:07:40 INFO - Downloading packages: [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:07: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')]} 19:07:40 INFO - https://queue.taskcluster.net/v1/task/EDdfTcNgRSuWsa_XIhnz0A/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:07:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EDdfTcNgRSuWsa_XIhnz0A/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 19:07:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EDdfTcNgRSuWsa_XIhnz0A/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 19:07:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EDdfTcNgRSuWsa_XIhnz0A/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 19:07:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EDdfTcNgRSuWsa_XIhnz0A/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 19:07:40 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EDdfTcNgRSuWsa_XIhnz0A/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 19:07:40 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 19:07:40 INFO - retry: Failed, sleeping 30 seconds before retrying 19:08:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EDdfTcNgRSuWsa_XIhnz0A/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 19:08:10 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EDdfTcNgRSuWsa_XIhnz0A/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 19:08:10 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 19:08:10 INFO - retry: Failed, sleeping 60 seconds before retrying 19:09:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EDdfTcNgRSuWsa_XIhnz0A/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 19:09:10 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EDdfTcNgRSuWsa_XIhnz0A/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 19:09:10 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 19:09:10 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EDdfTcNgRSuWsa_XIhnz0A/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! 19:09:10 INFO - Caught exception: HTTP Error 404: Not Found 19:09:10 INFO - Caught exception: HTTP Error 404: Not Found 19:09:10 INFO - Caught exception: HTTP Error 404: Not Found 19:09:10 INFO - trying https://queue.taskcluster.net/v1/task/EDdfTcNgRSuWsa_XIhnz0A/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 19:09:10 INFO - Downloading https://queue.taskcluster.net/v1/task/EDdfTcNgRSuWsa_XIhnz0A/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 19:09:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EDdfTcNgRSuWsa_XIhnz0A/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 19:09:11 INFO - Downloaded 21772468 bytes. 19:09:11 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'] 19:09:11 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 19:09:12 INFO - Return code: 0 19:09:12 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 19:09:12 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')]} 19:09:12 INFO - https://queue.taskcluster.net/v1/task/EDdfTcNgRSuWsa_XIhnz0A/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:09:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EDdfTcNgRSuWsa_XIhnz0A/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 19:09:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EDdfTcNgRSuWsa_XIhnz0A/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 19:09:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EDdfTcNgRSuWsa_XIhnz0A/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 19:09:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EDdfTcNgRSuWsa_XIhnz0A/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 19:09:12 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EDdfTcNgRSuWsa_XIhnz0A/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 19:09:12 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 19:09:12 INFO - retry: Failed, sleeping 30 seconds before retrying 19:09:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EDdfTcNgRSuWsa_XIhnz0A/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 19:09:42 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EDdfTcNgRSuWsa_XIhnz0A/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 19:09:42 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 19:09:42 INFO - retry: Failed, sleeping 60 seconds before retrying 19:10:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EDdfTcNgRSuWsa_XIhnz0A/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 19:10:42 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EDdfTcNgRSuWsa_XIhnz0A/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 19:10:42 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 19:10:42 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EDdfTcNgRSuWsa_XIhnz0A/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! 19:10:42 INFO - Caught exception: HTTP Error 404: Not Found 19:10:42 INFO - Caught exception: HTTP Error 404: Not Found 19:10:42 INFO - Caught exception: HTTP Error 404: Not Found 19:10:42 INFO - trying https://queue.taskcluster.net/v1/task/EDdfTcNgRSuWsa_XIhnz0A/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 19:10:42 INFO - Downloading https://queue.taskcluster.net/v1/task/EDdfTcNgRSuWsa_XIhnz0A/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 19:10:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EDdfTcNgRSuWsa_XIhnz0A/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 19:10:43 INFO - Downloaded 21772468 bytes. 19:10:43 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'] 19:10:43 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 19:10:44 INFO - Return code: 0 19:10:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:10:44 INFO - https://queue.taskcluster.net/v1/task/EDdfTcNgRSuWsa_XIhnz0A/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:10:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EDdfTcNgRSuWsa_XIhnz0A/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 19:10:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EDdfTcNgRSuWsa_XIhnz0A/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 19:10:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EDdfTcNgRSuWsa_XIhnz0A/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 19:10:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EDdfTcNgRSuWsa_XIhnz0A/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 19:10:44 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EDdfTcNgRSuWsa_XIhnz0A/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 19:10:44 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 19:10:44 INFO - retry: Failed, sleeping 30 seconds before retrying 19:11:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EDdfTcNgRSuWsa_XIhnz0A/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 19:11:15 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EDdfTcNgRSuWsa_XIhnz0A/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 19:11:15 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 19:11:15 INFO - retry: Failed, sleeping 60 seconds before retrying 19:12:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EDdfTcNgRSuWsa_XIhnz0A/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 19:12:15 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EDdfTcNgRSuWsa_XIhnz0A/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 19:12:15 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 19:12:15 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EDdfTcNgRSuWsa_XIhnz0A/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! 19:12:15 INFO - Caught exception: HTTP Error 404: Not Found 19:12:15 INFO - Caught exception: HTTP Error 404: Not Found 19:12:15 INFO - Caught exception: HTTP Error 404: Not Found 19:12:15 INFO - trying https://queue.taskcluster.net/v1/task/EDdfTcNgRSuWsa_XIhnz0A/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 19:12:15 INFO - Downloading https://queue.taskcluster.net/v1/task/EDdfTcNgRSuWsa_XIhnz0A/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 19:12:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EDdfTcNgRSuWsa_XIhnz0A/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 19:12:15 INFO - Downloaded 14413740 bytes. 19:12:15 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'] 19:12:15 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 19:12:16 INFO - Return code: 0 19:12:16 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')]} 19:12:16 INFO - https://queue.taskcluster.net/v1/task/EDdfTcNgRSuWsa_XIhnz0A/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:12:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EDdfTcNgRSuWsa_XIhnz0A/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 19:12:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EDdfTcNgRSuWsa_XIhnz0A/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 19:12:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EDdfTcNgRSuWsa_XIhnz0A/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 19:12:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EDdfTcNgRSuWsa_XIhnz0A/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 19:12:16 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EDdfTcNgRSuWsa_XIhnz0A/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 19:12:16 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 19:12:16 INFO - retry: Failed, sleeping 30 seconds before retrying 19:12:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EDdfTcNgRSuWsa_XIhnz0A/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 19:12:46 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EDdfTcNgRSuWsa_XIhnz0A/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 19:12:46 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 19:12:46 INFO - retry: Failed, sleeping 60 seconds before retrying 19:13:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EDdfTcNgRSuWsa_XIhnz0A/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 19:13:46 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EDdfTcNgRSuWsa_XIhnz0A/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 19:13:46 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 19:13:46 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EDdfTcNgRSuWsa_XIhnz0A/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! 19:13:46 INFO - Caught exception: HTTP Error 404: Not Found 19:13:46 INFO - Caught exception: HTTP Error 404: Not Found 19:13:46 INFO - Caught exception: HTTP Error 404: Not Found 19:13:46 INFO - trying https://queue.taskcluster.net/v1/task/EDdfTcNgRSuWsa_XIhnz0A/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 19:13:46 INFO - Downloading https://queue.taskcluster.net/v1/task/EDdfTcNgRSuWsa_XIhnz0A/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 19:13:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EDdfTcNgRSuWsa_XIhnz0A/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 19:13:47 INFO - Downloaded 56779324 bytes. 19:13:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EDdfTcNgRSuWsa_XIhnz0A/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 19:13:47 INFO - mkdir: /builds/slave/test/properties 19:13:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:13:47 INFO - Writing to file /builds/slave/test/properties/build_url 19:13:47 INFO - Contents: 19:13:47 INFO - build_url:https://queue.taskcluster.net/v1/task/EDdfTcNgRSuWsa_XIhnz0A/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 19:13:47 INFO - Running post-action listener: _resource_record_post_action 19:13:47 INFO - Running post-action listener: set_extra_try_arguments 19:13:47 INFO - [mozharness: 2016-09-27 02:13:47.978920Z] Finished download-and-extract step (success) 19:13:47 INFO - [mozharness: 2016-09-27 02:13:47.979152Z] Running populate-webroot step. 19:13:47 INFO - Running pre-action listener: _resource_record_pre_action 19:13:47 INFO - Running main action method: populate_webroot 19:13:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:13:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:13:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:13:47 INFO - '--tppagecycles', 19:13:47 INFO - '7'], 19:13:47 INFO - 'tests': ['tsvgm']}}, 19:13:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:13:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:13:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:13:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:13:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:13:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:13:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:13:47 INFO - 'talos_options': ['--disable-e10s'], 19:13:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:13:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:13:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:13:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:13:47 INFO - 'talos_options': ['--disable-e10s'], 19:13:47 INFO - 'tests': ['damp', 'tps']}, 19:13:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:13:47 INFO - 'tests': ['damp', 'tps']}, 19:13:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:13:47 INFO - 'tests': ['dromaeo_dom']}, 19:13:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:13:47 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:13:47 INFO - 'tests': ['basic_compositor_video']}, 19:13:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:13:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:13:47 INFO - 'tests': ['a11yr', 19:13:47 INFO - 'ts_paint', 19:13:47 INFO - 'tpaint', 19:13:47 INFO - 'sessionrestore', 19:13:47 INFO - 'sessionrestore_no_auto_restore', 19:13:47 INFO - 'tabpaint']}, 19:13:47 INFO - 'other-e10s': {'tests': ['a11yr', 19:13:47 INFO - 'ts_paint', 19:13:47 INFO - 'tpaint', 19:13:47 INFO - 'sessionrestore', 19:13:47 INFO - 'sessionrestore_no_auto_restore', 19:13:47 INFO - 'tabpaint']}, 19:13:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:13:47 INFO - 'ts_paint', 19:13:47 INFO - 'tpaint', 19:13:47 INFO - 'sessionrestore', 19:13:47 INFO - 'sessionrestore_no_auto_restore', 19:13:47 INFO - 'tabpaint']}, 19:13:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:13:47 INFO - 'ts_paint', 19:13:47 INFO - 'tpaint', 19:13:47 INFO - 'sessionrestore', 19:13:47 INFO - 'sessionrestore_no_auto_restore', 19:13:47 INFO - 'tabpaint']}, 19:13:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:13:47 INFO - 'tests': ['a11yr', 19:13:47 INFO - 'ts_paint', 19:13:47 INFO - 'tpaint', 19:13:47 INFO - 'sessionrestore', 19:13:47 INFO - 'sessionrestore_no_auto_restore', 19:13:47 INFO - 'tabpaint']}, 19:13:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:13:47 INFO - 'tests': ['a11yr', 19:13:47 INFO - 'ts_paint', 19:13:47 INFO - 'tpaint', 19:13:47 INFO - 'sessionrestore', 19:13:47 INFO - 'sessionrestore_no_auto_restore', 19:13:47 INFO - 'tabpaint']}, 19:13:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:13:47 INFO - 'tests': ['tsvgx', 19:13:47 INFO - 'tsvgr_opacity', 19:13:47 INFO - 'tart', 19:13:47 INFO - 'tscrollx', 19:13:47 INFO - 'cart']}, 19:13:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:13:47 INFO - 'tsvgr_opacity', 19:13:47 INFO - 'tart', 19:13:47 INFO - 'tscrollx', 19:13:47 INFO - 'cart']}, 19:13:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:13:47 INFO - 'talos_options': ['--disable-e10s'], 19:13:47 INFO - 'tests': ['tp5o']}, 19:13:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:13:47 INFO - 'tests': ['tp5o']}, 19:13:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:13:47 INFO - 'talos_options': ['--disable-e10s', 19:13:47 INFO - '--xperf_path', 19:13:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:13:47 INFO - 'tests': ['tp5n']}, 19:13:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:13:47 INFO - 'talos_options': ['--xperf_path', 19:13:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:13:47 INFO - 'tests': ['tp5n']}}, 19:13:47 INFO - 'talos.zip': {'path': '', 19:13:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:13:47 INFO - Running post-action listener: _resource_record_post_action 19:13:47 INFO - [mozharness: 2016-09-27 02:13:47.996368Z] Finished populate-webroot step (success) 19:13:47 INFO - [mozharness: 2016-09-27 02:13:47.996456Z] Running create-virtualenv step. 19:13:47 INFO - Running pre-action listener: _resource_record_pre_action 19:13:47 INFO - Running main action method: create_virtualenv 19:13:47 INFO - Creating virtualenv /builds/slave/test/build/venv 19:13:47 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 19:13:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:13:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:13:48 INFO - Using real prefix '/usr' 19:13:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:13:48 INFO - Installing distribute.............................................................................................................................................................................................done. 19:13:50 INFO - Installing pip.................done. 19:13:50 INFO - Return code: 0 19:13:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:13:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:13:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:13:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:13:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:13:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:13:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:13:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2919030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a7c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b48400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd7570>, '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 0x2bd8470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd8900>, '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': '7de08804244eb36560b44971000001c3-1474941967.684827-1276825723', '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 19:13:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 19:13:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:13:50 INFO - Using env: {'DISPLAY': ':0', 19:13:50 INFO - 'HOME': '/home/cltbld', 19:13:50 INFO - 'LANG': 'en_US.UTF-8', 19:13:50 INFO - 'LANGUAGE': 'en_US:en', 19:13:50 INFO - 'LOGNAME': 'cltbld', 19:13:50 INFO - 'MAIL': '/var/mail/cltbld', 19:13:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:13:50 INFO - 'MOZ_NO_REMOTE': '1', 19:13:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:13:50 INFO - 'NO_EM_RESTART': '1', 19:13:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:13:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:13:50 INFO - 'PWD': '/builds/slave/test', 19:13:50 INFO - 'SHELL': '/bin/bash', 19:13:50 INFO - 'SHLVL': '1', 19:13:50 INFO - 'TERM': 'linux', 19:13:50 INFO - 'TMOUT': '86400', 19:13:50 INFO - 'USER': 'cltbld', 19:13:50 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1474941967.684827-1276825723', 19:13:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:13:50 INFO - '_': '/tools/buildbot/bin/python'} 19:13:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:13:50 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 19:13:50 INFO - Cleaning up... 19:13:50 INFO - Return code: 0 19:13:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:13:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:13:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:13:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:13:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:13:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:13:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:13:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x2919030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a7c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b48400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd7570>, '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 0x2bd8470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd8900>, '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': '7de08804244eb36560b44971000001c3-1474941967.684827-1276825723', '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 19:13:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 19:13:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 19:13:50 INFO - Using env: {'DISPLAY': ':0', 19:13:50 INFO - 'HOME': '/home/cltbld', 19:13:50 INFO - 'LANG': 'en_US.UTF-8', 19:13:50 INFO - 'LANGUAGE': 'en_US:en', 19:13:50 INFO - 'LOGNAME': 'cltbld', 19:13:50 INFO - 'MAIL': '/var/mail/cltbld', 19:13:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:13:50 INFO - 'MOZ_NO_REMOTE': '1', 19:13:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:13:50 INFO - 'NO_EM_RESTART': '1', 19:13:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:13:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:13:50 INFO - 'PWD': '/builds/slave/test', 19:13:50 INFO - 'SHELL': '/bin/bash', 19:13:50 INFO - 'SHLVL': '1', 19:13:50 INFO - 'TERM': 'linux', 19:13:50 INFO - 'TMOUT': '86400', 19:13:50 INFO - 'USER': 'cltbld', 19:13:50 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1474941967.684827-1276825723', 19:13:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:13:50 INFO - '_': '/tools/buildbot/bin/python'} 19:13:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:13:51 INFO - Downloading/unpacking psutil>=3.1.1 19:13:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:13:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:13:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:13:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:13:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:13:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:13:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:13:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:13:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:13:53 INFO - Installing collected packages: psutil 19:13:53 INFO - Running setup.py install for psutil 19:13:53 INFO - building 'psutil._psutil_linux' extension 19:13:53 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 19:13:53 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 19:13:53 INFO - building 'psutil._psutil_posix' extension 19:13:53 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 19:13:53 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 19:13:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:13:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:13:53 INFO - Successfully installed psutil 19:13:53 INFO - Cleaning up... 19:13:53 INFO - Return code: 0 19:13:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:13:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:13:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:13:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:13:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:13:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:13:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:13:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2919030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a7c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b48400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd7570>, '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 0x2bd8470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd8900>, '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': '7de08804244eb36560b44971000001c3-1474941967.684827-1276825723', '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 19:13:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 19:13:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 19:13:53 INFO - Using env: {'DISPLAY': ':0', 19:13:53 INFO - 'HOME': '/home/cltbld', 19:13:53 INFO - 'LANG': 'en_US.UTF-8', 19:13:53 INFO - 'LANGUAGE': 'en_US:en', 19:13:53 INFO - 'LOGNAME': 'cltbld', 19:13:53 INFO - 'MAIL': '/var/mail/cltbld', 19:13:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:13:53 INFO - 'MOZ_NO_REMOTE': '1', 19:13:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:13:53 INFO - 'NO_EM_RESTART': '1', 19:13:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:13:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:13:53 INFO - 'PWD': '/builds/slave/test', 19:13:53 INFO - 'SHELL': '/bin/bash', 19:13:53 INFO - 'SHLVL': '1', 19:13:53 INFO - 'TERM': 'linux', 19:13:53 INFO - 'TMOUT': '86400', 19:13:53 INFO - 'USER': 'cltbld', 19:13:53 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1474941967.684827-1276825723', 19:13:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:13:53 INFO - '_': '/tools/buildbot/bin/python'} 19:13:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:13:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:13:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:13:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:13:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:13:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:13:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:13:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:13:55 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:13:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:13:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:13:55 INFO - Installing collected packages: mozsystemmonitor 19:13:55 INFO - Running setup.py install for mozsystemmonitor 19:13:55 INFO - Successfully installed mozsystemmonitor 19:13:55 INFO - Cleaning up... 19:13:55 INFO - Return code: 0 19:13:55 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:13:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:13:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:13:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:13:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:13:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:13:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:13:55 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 0x2919030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a7c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b48400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd7570>, '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 0x2bd8470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd8900>, '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': '7de08804244eb36560b44971000001c3-1474941967.684827-1276825723', '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 19:13:55 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 19:13:55 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 19:13:55 INFO - Using env: {'DISPLAY': ':0', 19:13:55 INFO - 'HOME': '/home/cltbld', 19:13:55 INFO - 'LANG': 'en_US.UTF-8', 19:13:55 INFO - 'LANGUAGE': 'en_US:en', 19:13:55 INFO - 'LOGNAME': 'cltbld', 19:13:55 INFO - 'MAIL': '/var/mail/cltbld', 19:13:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:13:55 INFO - 'MOZ_NO_REMOTE': '1', 19:13:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:13:55 INFO - 'NO_EM_RESTART': '1', 19:13:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:13:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:13:55 INFO - 'PWD': '/builds/slave/test', 19:13:55 INFO - 'SHELL': '/bin/bash', 19:13:55 INFO - 'SHLVL': '1', 19:13:55 INFO - 'TERM': 'linux', 19:13:55 INFO - 'TMOUT': '86400', 19:13:55 INFO - 'USER': 'cltbld', 19:13:55 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1474941967.684827-1276825723', 19:13:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:13:55 INFO - '_': '/tools/buildbot/bin/python'} 19:13:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:13:56 INFO - Downloading/unpacking jsonschema==2.5.1 19:13:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:13:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:13:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:13:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:13:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:13:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:13:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:13:57 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:13:57 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 19:13:57 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 19:13:57 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 19:13:57 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 19:13:57 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 19:13:57 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 19:13:58 INFO - Downloading functools32-3.2.3-2.tar.gz 19:13:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:13:58 INFO - warning: no files found matching '*.txt' 19:13:58 INFO - no previously-included directories found matching 'build' 19:13:58 INFO - no previously-included directories found matching 'dist' 19:13:58 INFO - no previously-included directories found matching '.git*' 19:13:58 INFO - Installing collected packages: jsonschema, functools32 19:13:58 INFO - Running setup.py install for functools32 19:13:58 INFO - warning: no files found matching '*.txt' 19:13:58 INFO - no previously-included directories found matching 'build' 19:13:58 INFO - no previously-included directories found matching 'dist' 19:13:58 INFO - no previously-included directories found matching '.git*' 19:13:58 INFO - Successfully installed jsonschema functools32 19:13:58 INFO - Cleaning up... 19:13:58 INFO - Return code: 0 19:13:58 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:13:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:13:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:13:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:13:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:13:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:13:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:13:58 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 0x2919030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a7c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b48400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd7570>, '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 0x2bd8470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd8900>, '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': '7de08804244eb36560b44971000001c3-1474941967.684827-1276825723', '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 19:13:58 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 19:13:58 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 19:13:58 INFO - Using env: {'DISPLAY': ':0', 19:13:58 INFO - 'HOME': '/home/cltbld', 19:13:58 INFO - 'LANG': 'en_US.UTF-8', 19:13:58 INFO - 'LANGUAGE': 'en_US:en', 19:13:58 INFO - 'LOGNAME': 'cltbld', 19:13:58 INFO - 'MAIL': '/var/mail/cltbld', 19:13:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:13:58 INFO - 'MOZ_NO_REMOTE': '1', 19:13:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:13:58 INFO - 'NO_EM_RESTART': '1', 19:13:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:13:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:13:58 INFO - 'PWD': '/builds/slave/test', 19:13:58 INFO - 'SHELL': '/bin/bash', 19:13:58 INFO - 'SHLVL': '1', 19:13:58 INFO - 'TERM': 'linux', 19:13:58 INFO - 'TMOUT': '86400', 19:13:58 INFO - 'USER': 'cltbld', 19:13:58 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1474941967.684827-1276825723', 19:13:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:13:58 INFO - '_': '/tools/buildbot/bin/python'} 19:13:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:13:58 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:13:58 INFO - Cleaning up... 19:13:58 INFO - Return code: 0 19:13:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:13:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:13:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:13:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:13:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:13:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:13:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:13:58 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 0x2919030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a7c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b48400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd7570>, '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 0x2bd8470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd8900>, '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': '7de08804244eb36560b44971000001c3-1474941967.684827-1276825723', '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 19:13:58 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 19:13:58 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 19:13:58 INFO - Using env: {'DISPLAY': ':0', 19:13:58 INFO - 'HOME': '/home/cltbld', 19:13:58 INFO - 'LANG': 'en_US.UTF-8', 19:13:58 INFO - 'LANGUAGE': 'en_US:en', 19:13:58 INFO - 'LOGNAME': 'cltbld', 19:13:58 INFO - 'MAIL': '/var/mail/cltbld', 19:13:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:13:58 INFO - 'MOZ_NO_REMOTE': '1', 19:13:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:13:58 INFO - 'NO_EM_RESTART': '1', 19:13:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:13:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:13:58 INFO - 'PWD': '/builds/slave/test', 19:13:58 INFO - 'SHELL': '/bin/bash', 19:13:58 INFO - 'SHLVL': '1', 19:13:58 INFO - 'TERM': 'linux', 19:13:58 INFO - 'TMOUT': '86400', 19:13:58 INFO - 'USER': 'cltbld', 19:13:58 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1474941967.684827-1276825723', 19:13:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:13:58 INFO - '_': '/tools/buildbot/bin/python'} 19:13:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:13:58 INFO - Downloading/unpacking blobuploader==1.2.4 19:13:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:13:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:13:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:13:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:13:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:13:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:14:00 INFO - Downloading blobuploader-1.2.4.tar.gz 19:14:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:14:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:14:00 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 19:14:00 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 19:14:00 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 19:14:00 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 19:14:00 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 19:14:00 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 19:14:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:14:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:14:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:14:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:14:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:14:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:14:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:14:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:14:01 INFO - Downloading docopt-0.6.1.tar.gz 19:14:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:14:01 INFO - Installing collected packages: blobuploader, requests, docopt 19:14:01 INFO - Running setup.py install for blobuploader 19:14:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:14:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:14:01 INFO - Running setup.py install for requests 19:14:02 INFO - Running setup.py install for docopt 19:14:02 INFO - Successfully installed blobuploader requests docopt 19:14:02 INFO - Cleaning up... 19:14:02 INFO - Return code: 0 19:14:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:14:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:14:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:14:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:14:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:14:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:14:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:14:02 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 0x2919030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a7c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b48400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd7570>, '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 0x2bd8470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd8900>, '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': '7de08804244eb36560b44971000001c3-1474941967.684827-1276825723', '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 19:14:02 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 19:14:02 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 19:14:02 INFO - Using env: {'DISPLAY': ':0', 19:14:02 INFO - 'HOME': '/home/cltbld', 19:14:02 INFO - 'LANG': 'en_US.UTF-8', 19:14:02 INFO - 'LANGUAGE': 'en_US:en', 19:14:02 INFO - 'LOGNAME': 'cltbld', 19:14:02 INFO - 'MAIL': '/var/mail/cltbld', 19:14:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:14:02 INFO - 'MOZ_NO_REMOTE': '1', 19:14:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:14:02 INFO - 'NO_EM_RESTART': '1', 19:14:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:14:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:14:02 INFO - 'PWD': '/builds/slave/test', 19:14:02 INFO - 'SHELL': '/bin/bash', 19:14:02 INFO - 'SHLVL': '1', 19:14:02 INFO - 'TERM': 'linux', 19:14:02 INFO - 'TMOUT': '86400', 19:14:02 INFO - 'USER': 'cltbld', 19:14:02 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1474941967.684827-1276825723', 19:14:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:14:02 INFO - '_': '/tools/buildbot/bin/python'} 19:14:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:14:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:14:02 INFO - Running setup.py (path:/tmp/pip-jr_WEL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:14:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:14:02 INFO - Running setup.py (path:/tmp/pip-ONkspp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:14:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:14:02 INFO - Running setup.py (path:/tmp/pip-eLh4gV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:14:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:14:02 INFO - Running setup.py (path:/tmp/pip-UHdCRd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:14:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:14:02 INFO - Running setup.py (path:/tmp/pip-B2ArIG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:14:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:14:02 INFO - Running setup.py (path:/tmp/pip-0UfjFA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:14:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:14:02 INFO - Running setup.py (path:/tmp/pip-iw8riG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:14:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:14:02 INFO - Running setup.py (path:/tmp/pip-m1N_AH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:14:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:14:02 INFO - Running setup.py (path:/tmp/pip-jBV5pn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:14:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:14:03 INFO - Running setup.py (path:/tmp/pip-PKGvRg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:14:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:14:03 INFO - Running setup.py (path:/tmp/pip-QFUdLa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:14:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:14:03 INFO - Running setup.py (path:/tmp/pip-MUoPKA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:14:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:14:03 INFO - Running setup.py (path:/tmp/pip-kqmUst-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:14:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:14:03 INFO - Running setup.py (path:/tmp/pip-1FJ0v_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:14:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:14:03 INFO - Running setup.py (path:/tmp/pip-y3Gk14-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:14:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:14:03 INFO - Running setup.py (path:/tmp/pip-JrElN0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:14:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:14:03 INFO - Running setup.py (path:/tmp/pip-HiE8XX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:14:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:14:03 INFO - Running setup.py install for manifestparser 19:14:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:14:03 INFO - Running setup.py install for mozcrash 19:14:03 INFO - Running setup.py install for mozdebug 19:14:03 INFO - Running setup.py install for mozdevice 19:14:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:14:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:14:04 INFO - Running setup.py install for mozfile 19:14:04 INFO - Running setup.py install for mozhttpd 19:14:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:14:04 INFO - Running setup.py install for mozinfo 19:14:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:14:04 INFO - Running setup.py install for mozInstall 19:14:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:14:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:14:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:14:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:14:04 INFO - Running setup.py install for mozleak 19:14:04 INFO - Running setup.py install for mozlog 19:14:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:14:04 INFO - Running setup.py install for moznetwork 19:14:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:14:04 INFO - Running setup.py install for mozprocess 19:14:04 INFO - Running setup.py install for mozprofile 19:14:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:14:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:14:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:14:04 INFO - Running setup.py install for mozrunner 19:14:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:14:05 INFO - Running setup.py install for mozscreenshot 19:14:05 INFO - Running setup.py install for moztest 19:14:05 INFO - Running setup.py install for mozversion 19:14:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:14:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:14:05 INFO - Cleaning up... 19:14:05 INFO - Return code: 0 19:14:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:14: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')]} 19:14:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:14:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:14: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')]} 19:14:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:14:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:14:05 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 0x2919030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a7c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b48400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd7570>, '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 0x2bd8470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd8900>, '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': '7de08804244eb36560b44971000001c3-1474941967.684827-1276825723', '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 19:14:05 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 19:14:05 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 19:14:05 INFO - Using env: {'DISPLAY': ':0', 19:14:05 INFO - 'HOME': '/home/cltbld', 19:14:05 INFO - 'LANG': 'en_US.UTF-8', 19:14:05 INFO - 'LANGUAGE': 'en_US:en', 19:14:05 INFO - 'LOGNAME': 'cltbld', 19:14:05 INFO - 'MAIL': '/var/mail/cltbld', 19:14:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:14:05 INFO - 'MOZ_NO_REMOTE': '1', 19:14:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:14:05 INFO - 'NO_EM_RESTART': '1', 19:14:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:14:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:14:05 INFO - 'PWD': '/builds/slave/test', 19:14:05 INFO - 'SHELL': '/bin/bash', 19:14:05 INFO - 'SHLVL': '1', 19:14:05 INFO - 'TERM': 'linux', 19:14:05 INFO - 'TMOUT': '86400', 19:14:05 INFO - 'USER': 'cltbld', 19:14:05 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1474941967.684827-1276825723', 19:14:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:14:05 INFO - '_': '/tools/buildbot/bin/python'} 19:14:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:14:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:14:05 INFO - Running setup.py (path:/tmp/pip-oUjfEW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:14:05 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)) 19:14:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:14:05 INFO - Running setup.py (path:/tmp/pip-jaW3yw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:14:05 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)) 19:14:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:14:05 INFO - Running setup.py (path:/tmp/pip-pI0AL6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:14:05 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)) 19:14:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:14:05 INFO - Running setup.py (path:/tmp/pip-GePQg0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:14:05 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)) 19:14:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:14:05 INFO - Running setup.py (path:/tmp/pip-3Dnxzf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:14:05 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)) 19:14:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:14:05 INFO - Running setup.py (path:/tmp/pip-JNtVWb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:14:06 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)) 19:14:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:14:06 INFO - Running setup.py (path:/tmp/pip-e4WJn3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:14:06 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)) 19:14:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:14:06 INFO - Running setup.py (path:/tmp/pip-mvFS6S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:14:06 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)) 19:14:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:14:06 INFO - Running setup.py (path:/tmp/pip-2C2r5d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:14:06 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)) 19:14:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:14:06 INFO - Running setup.py (path:/tmp/pip-sdVqFj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:14:06 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)) 19:14:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:14:06 INFO - Running setup.py (path:/tmp/pip-r_KBmr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:14:06 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)) 19:14:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:14:06 INFO - Running setup.py (path:/tmp/pip-K0CUb3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:14:06 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)) 19:14:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:14:06 INFO - Running setup.py (path:/tmp/pip-2IHlrK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:14:06 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)) 19:14:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:14:06 INFO - Running setup.py (path:/tmp/pip-zhWvAW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:14:06 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)) 19:14:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:14:06 INFO - Running setup.py (path:/tmp/pip-pCerEz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:14:06 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)) 19:14:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:14:06 INFO - Running setup.py (path:/tmp/pip-TkyDyo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:14:06 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)) 19:14:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:14:06 INFO - Running setup.py (path:/tmp/pip-HkZokP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:14:06 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)) 19:14:06 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)) 19:14:06 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)) 19:14:06 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)) 19:14:06 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)) 19:14:06 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)) 19:14:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:14:06 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 19:14:06 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 19:14:06 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 19:14:06 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 19:14:06 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 19:14:06 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 19:14:08 INFO - Downloading blessings-1.6.tar.gz 19:14:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:14:08 INFO - Installing collected packages: blessings 19:14:08 INFO - Running setup.py install for blessings 19:14:08 INFO - Successfully installed blessings 19:14:08 INFO - Cleaning up... 19:14:09 INFO - Return code: 0 19:14:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:14:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:14:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:14:09 INFO - Reading from file tmpfile_stdout 19:14:09 INFO - Current package versions: 19:14:09 INFO - argparse == 1.2.1 19:14:09 INFO - blessings == 1.6 19:14:09 INFO - blobuploader == 1.2.4 19:14:09 INFO - docopt == 0.6.1 19:14:09 INFO - functools32 == 3.2.3-2 19:14:09 INFO - jsonschema == 2.5.1 19:14:09 INFO - manifestparser == 1.1 19:14:09 INFO - mozInstall == 1.12 19:14:09 INFO - mozcrash == 0.17 19:14:09 INFO - mozdebug == 0.1 19:14:09 INFO - mozdevice == 0.48 19:14:09 INFO - mozfile == 1.2 19:14:09 INFO - mozhttpd == 0.7 19:14:09 INFO - mozinfo == 0.9 19:14:09 INFO - mozleak == 0.1 19:14:09 INFO - mozlog == 3.3 19:14:09 INFO - moznetwork == 0.27 19:14:09 INFO - mozprocess == 0.23 19:14:09 INFO - mozprofile == 0.28 19:14:09 INFO - mozrunner == 6.12 19:14:09 INFO - mozscreenshot == 0.1 19:14:09 INFO - mozsystemmonitor == 0.3 19:14:09 INFO - moztest == 0.7 19:14:09 INFO - mozversion == 1.4 19:14:09 INFO - psutil == 3.1.1 19:14:09 INFO - requests == 1.2.3 19:14:09 INFO - wsgiref == 0.1.2 19:14:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19: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')]} 19:14:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:14:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19: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')]} 19:14:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:14:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:14:09 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 0x2919030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a7c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b48400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd7570>, '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 0x2bd8470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd8900>, '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': '7de08804244eb36560b44971000001c3-1474941967.684827-1276825723', '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 19:14:09 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 19:14:09 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 19:14:09 INFO - Using env: {'DISPLAY': ':0', 19:14:09 INFO - 'HOME': '/home/cltbld', 19:14:09 INFO - 'LANG': 'en_US.UTF-8', 19:14:09 INFO - 'LANGUAGE': 'en_US:en', 19:14:09 INFO - 'LOGNAME': 'cltbld', 19:14:09 INFO - 'MAIL': '/var/mail/cltbld', 19:14:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:14:09 INFO - 'MOZ_NO_REMOTE': '1', 19:14:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:14:09 INFO - 'NO_EM_RESTART': '1', 19:14:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:14:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:14:09 INFO - 'PWD': '/builds/slave/test', 19:14:09 INFO - 'SHELL': '/bin/bash', 19:14:09 INFO - 'SHLVL': '1', 19:14:09 INFO - 'TERM': 'linux', 19:14:09 INFO - 'TMOUT': '86400', 19:14:09 INFO - 'USER': 'cltbld', 19:14:09 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1474941967.684827-1276825723', 19:14:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:14:09 INFO - '_': '/tools/buildbot/bin/python'} 19:14:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:14:09 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)) 19:14:09 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)) 19:14:09 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)) 19:14:09 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)) 19:14:09 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)) 19:14:09 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)) 19:14:09 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)) 19:14:09 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)) 19:14:09 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)) 19:14:09 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)) 19:14:09 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)) 19:14:09 INFO - Cleaning up... 19:14:09 INFO - Return code: 0 19:14:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19: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')]} 19:14:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:14:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19: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')]} 19:14:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:14:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:14:09 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 0x2919030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a7c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b48400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd7570>, '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 0x2bd8470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd8900>, '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': '7de08804244eb36560b44971000001c3-1474941967.684827-1276825723', '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 19:14:09 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 19:14:09 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 19:14:09 INFO - Using env: {'DISPLAY': ':0', 19:14:09 INFO - 'HOME': '/home/cltbld', 19:14:09 INFO - 'LANG': 'en_US.UTF-8', 19:14:09 INFO - 'LANGUAGE': 'en_US:en', 19:14:09 INFO - 'LOGNAME': 'cltbld', 19:14:09 INFO - 'MAIL': '/var/mail/cltbld', 19:14:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:14:09 INFO - 'MOZ_NO_REMOTE': '1', 19:14:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:14:09 INFO - 'NO_EM_RESTART': '1', 19:14:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:14:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:14:09 INFO - 'PWD': '/builds/slave/test', 19:14:09 INFO - 'SHELL': '/bin/bash', 19:14:09 INFO - 'SHLVL': '1', 19:14:09 INFO - 'TERM': 'linux', 19:14:09 INFO - 'TMOUT': '86400', 19:14:09 INFO - 'USER': 'cltbld', 19:14:09 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1474941967.684827-1276825723', 19:14:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:14:09 INFO - '_': '/tools/buildbot/bin/python'} 19:14:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:14:09 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:14:09 INFO - Cleaning up... 19:14:09 INFO - Return code: 0 19:14:09 INFO - Running post-action listener: _resource_record_post_action 19:14:09 INFO - Running post-action listener: _start_resource_monitoring 19:14:09 INFO - Starting resource monitoring. 19:14:09 INFO - [mozharness: 2016-09-27 02:14:09.732517Z] Finished create-virtualenv step (success) 19:14:09 INFO - [mozharness: 2016-09-27 02:14:09.732954Z] Running install step. 19:14:09 INFO - Running pre-action listener: _resource_record_pre_action 19:14:09 INFO - Running main action method: install 19:14:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:14:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:14:09 INFO - Reading from file tmpfile_stdout 19:14:09 INFO - Detecting whether we're running mozinstall >=1.0... 19:14:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:14:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:14:10 INFO - Reading from file tmpfile_stdout 19:14:10 INFO - Output received: 19:14:10 INFO - Usage: mozinstall [options] installer 19:14:10 INFO - Options: 19:14:10 INFO - -h, --help show this help message and exit 19:14:10 INFO - -d DEST, --destination=DEST 19:14:10 INFO - Directory to install application into. [default: 19:14:10 INFO - "/builds/slave/test"] 19:14:10 INFO - --app=APP Application being installed. [default: firefox] 19:14:10 INFO - mkdir: /builds/slave/test/build/application 19:14:10 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'] 19:14:10 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 19:14:23 INFO - Reading from file tmpfile_stdout 19:14:23 INFO - Output received: 19:14:23 INFO - /builds/slave/test/build/application/firefox/firefox 19:14:23 INFO - Running post-action listener: _resource_record_post_action 19:14:23 INFO - [mozharness: 2016-09-27 02:14:23.496473Z] Finished install step (success) 19:14:23 INFO - [mozharness: 2016-09-27 02:14:23.496755Z] Running run-tests step. 19:14:23 INFO - Running pre-action listener: _resource_record_pre_action 19:14:23 INFO - Running main action method: run_tests 19:14:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:14:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:14:23 INFO - Python 2.7.3 19:14:23 INFO - Return code: 0 19:14:23 INFO - grabbing minidump binary from tooltool 19:14: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')]} 19:14:23 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 0x2bd7570>, '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 0x2bd8470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd8900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:14:23 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 19:14:23 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 19:14:23 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 19:14:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:14:23 INFO - Return code: 0 19:14:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:14:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:14:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:14:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:14:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:14:23 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/EDdfTcNgRSuWsa_XIhnz0A/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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 19:14:23 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/EDdfTcNgRSuWsa_XIhnz0A/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-003 --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 19:14:23 INFO - Using env: {'DISPLAY': ':0', 19:14:23 INFO - 'HOME': '/home/cltbld', 19:14:23 INFO - 'LANG': 'en_US.UTF-8', 19:14:23 INFO - 'LANGUAGE': 'en_US:en', 19:14:23 INFO - 'LOGNAME': 'cltbld', 19:14:23 INFO - 'MAIL': '/var/mail/cltbld', 19:14:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:14:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:14:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:14:23 INFO - 'MOZ_NO_REMOTE': '1', 19:14:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:14:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:14:23 INFO - 'NO_EM_RESTART': '1', 19:14:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:14:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:14:23 INFO - 'PWD': '/builds/slave/test', 19:14:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:14:23 INFO - 'SHELL': '/bin/bash', 19:14:23 INFO - 'SHLVL': '1', 19:14:23 INFO - 'TERM': 'linux', 19:14:23 INFO - 'TMOUT': '86400', 19:14:23 INFO - 'USER': 'cltbld', 19:14:23 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1474941967.684827-1276825723', 19:14:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:14:23 INFO - '_': '/tools/buildbot/bin/python'} 19:14:23 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/EDdfTcNgRSuWsa_XIhnz0A/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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 19:14:23 INFO - mozversion application_buildid: 20160926162149 19:14:23 INFO - mozversion application_changeset: 865939f4946d80fa532aaa168515a2fe69f9a774 19:14:23 INFO - mozversion application_display_name: Firefox 19:14:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:14:23 INFO - mozversion application_name: Firefox 19:14:23 INFO - mozversion application_remotingname: firefox 19:14:23 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 19:14:23 INFO - mozversion application_vendor: Mozilla 19:14:23 INFO - mozversion application_version: 50.0 19:14:23 INFO - mozversion platform_buildid: 20160926162149 19:14:23 INFO - mozversion platform_changeset: 865939f4946d80fa532aaa168515a2fe69f9a774 19:14:23 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 19:14:23 INFO - mozversion platform_version: 50.0 19:14:23 INFO - using testdate: 1474942463 19:14:23 INFO - actual date: 1474942463 19:14:23 INFO - starting webserver on 'localhost:41571' 19:14:23 INFO - SUITE-START | Running 2 tests 19:14:23 INFO - TEST-START | dromaeo_css 19:14:23 INFO - operating with platform_type : linux_ 19:14:23 INFO - Initialising browser for dromaeo_css test... 19:14:23 INFO - TEST-INFO | started process 3412 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBtxHt9/profile http://localhost:41571/getInfo.html) 19:14:28 INFO - PROCESS | 3412 | __metrics Screen width/height:1600/1200 19:14:28 INFO - PROCESS | 3412 | colorDepth:24 19:14:28 INFO - PROCESS | 3412 | Browser inner width/height: 1024/697 19:14:28 INFO - PROCESS | 3412 | __metrics 19:14:29 ERROR - PROCESS | 3412 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 19:14:29 INFO - TEST-INFO | 3412: exit 0 19:14:29 INFO - Browser initialized. 19:14:29 INFO - Running cycle 1/1 for dromaeo_css test... 19:14:29 INFO - TEST-INFO | started process 3534 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBtxHt9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:14:41 INFO - PROCESS | 3534 | RSS: Main: 149331968 19:14:41 INFO - PROCESS | 3534 | 19:15:31 INFO - PROCESS | 3534 | 1474942531184 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] 19:17:39 INFO - PROCESS | 3534 | Cycle 1(1): loaded http://localhost:41571/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41571/tests/dromaeo/cssquery-ext.html) 19:17:41 INFO - PROCESS | 3534 | RSS: Main: 157704192 19:17:41 INFO - PROCESS | 3534 | 19:20:43 INFO - PROCESS | 3534 | Cycle 1(1): loaded http://localhost:41571/tests/dromaeo/cssquery-ext.html (next: http://localhost:41571/tests/dromaeo/cssquery-jquery.html) 19:20:43 INFO - PROCESS | 3534 | RSS: Main: 155451392 19:20:43 INFO - PROCESS | 3534 | 19:23:45 INFO - PROCESS | 3534 | Cycle 1(1): loaded http://localhost:41571/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41571/tests/dromaeo/cssquery-mootools.html) 19:23:46 INFO - PROCESS | 3534 | RSS: Main: 154832896 19:23:46 INFO - PROCESS | 3534 | 19:26:47 INFO - PROCESS | 3534 | Cycle 1(1): loaded http://localhost:41571/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41571/tests/dromaeo/cssquery-prototype.html) 19:26:48 INFO - PROCESS | 3534 | RSS: Main: 156545024 19:26:48 INFO - PROCESS | 3534 | 19:29:50 INFO - PROCESS | 3534 | Cycle 1(1): loaded http://localhost:41571/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41571/tests/dromaeo/cssquery-yui.html) 19:29:51 INFO - PROCESS | 3534 | RSS: Main: 157224960 19:29:51 INFO - PROCESS | 3534 | 19:32:53 INFO - PROCESS | 3534 | Cycle 1(1): loaded http://localhost:41571/tests/dromaeo/cssquery-yui.html (next: http://localhost:41571/tests/dromaeo/cssquery-dojo.html) 19:32:53 INFO - PROCESS | 3534 | RSS: Main: 157360128 19:32:53 INFO - PROCESS | 3534 | 19:32:53 INFO - PROCESS | 3534 | __start_tp_report 19:32:53 INFO - PROCESS | 3534 | _x_x_mozilla_page_load 19:32:53 INFO - PROCESS | 3534 | _x_x_mozilla_page_load_details 19:32:53 INFO - PROCESS | 3534 | |i|pagename|runs| 19:32:53 INFO - PROCESS | 3534 | |0;dojo.html;3346.1634591352163;3352.296017836254;3360.1935535471493;3377.847996840142;3382.0868365541305;5885.058390657496;5934.317553481351;5969.970150149248;5972.910406343903;5976.133460648203;5923.200367950336;5927.466528012478;5929.169916211723;5943.049112142058;5950.970245148779;5092.439831618519;5316.494932981361;5357.464253574651;5436.972815135919;5464.9180262295895;5245.68525888446;5325.360956685184;5342.839714808562;5373.408925018264;5438.320209973754;5390.164524498709;5414.729263536808;5415.458454154573;5416.052190866602;5453.7818487260465;5463.508284254396;5464.7540860661165;5473.726313684339;5489.890202195954;5521.2270282160525;5071.594272458195;5089.872753181163;5187.844364669028;5378.354597448292;5391.406945236021;5823.359430462646;5840.299164100293;5852.063669812852;5865.325487568942;5918.556108291896;6242.157308763304;6286.245650521921;6287.182666253358;6317.557770956035;6322.462590679797;6163.8150855474405;6243.469305109071;6299.622022678654;6315.747370105236;6367.044943258548;5948.40515948406;5951.166836642873;5952.523798096142;5971.880562388771;6000.939990600082;6459.09572659828;6483.902741458882;6496.039485730219;6517.608943463408;6527.54307198501;5983.222181116427;6156.107364432221;6157.507399408037;6253.499720022387;6281.371862813773;6366.427021567988;6389.808305750835;6421.422072013448;6426.582272152295;6437.774677886345;6352.841178970562;6390.424861762371;6393.296737358887;6399.968000159969;6401.423871851555;6139.693015349215;6206.06908963659;6224.502039836802;6353.714082866282;6359.141515895295;4820.373351464287;4822.469528351879;4824.228123500223;4837.685550439211;4867.318575399447;4281.357796330575;4286.142771445723;4301.182775272689;4318;4318.805653745589;5972.313183983811;6047.0627052806;6075.149479072933;6114.174586430775;6123.846903827351;6467.708953097028;6505.7397704092255;6516.609003459807;6518.608883467007;6535.934640653628;6141.907871381933;6154.815355539341;6171.9691401542705;6204.968975155095;6207.81376558704;5301.1783173608155;5395.163749618815;5399.622026458111;5508.724563771795;5509.090999985037;6622.10601568782;6652.900206496906;6677.198736151596;6688.866222675617;6700.262971073178;6428.582142160744;6451.258105317761;6478.222613286436;6478.70845811949;6488.383603557654;6357.968210159104;6411.647359395278;6454.67726613658;6613.074169616161;6678.131842860397;6327.209098862642;6345.365463453618;6349.777757778455;6354.968225158845;6356.491480681442;6473.77341793035;6474.4820414365795;6478.481721462177;6498.870022599427;6506.4469520091325;6009.579329447071;6137.315698287052;6214.5028397727165;6311.810645680637;6322.051692246016;6249.062640603764;6279;6280.466160376236;6281.403266689657;6311.084892690443;6242.65665388408;6265.56141070139;6269.96865015672;6272.18461599989;6274.8431289216305;6139.15007144351;6158.599691020069;6184.567080304336;6318.052292156213;6329.7151628175925;6137.162486020116;6154.846128846814;6161.568690191643;6167.876642467215;6168.0439531872635 19:32:53 INFO - PROCESS | 3534 | |1;ext.html;576.2738948924357;614.8862460444817;631.4064779107639;648.432621456226;690.7513295213726;40103.398449023254;44855.77572112135;45012.77493612535;45028.999999999956;45063.324050139236;44510;44600.10799784002;45167.54832451683;45358.77320613401;45504;7908.644111015004;8015.118336982927;8015.4389192756535;8042.517448953082;8058.919410805905;9215.95392023039;9255.907440925606;9296.116868897478;9297.72106836796;9297.860532092023;9352.298577606673;9357.438553686767;9378.577963991636;9397.906020939805;9428.292878034175;9284.814303713922;9324.300677449219;9327.253819694475;9334.346595738267;9335.53322333884;9143.725688229364;9217.170454659114;9223.584938677775;9230;9235.492047937361;43032.139357213;43132.35301470481;43203;43281.567184328065;43309.133817323476;3868.6518213360932;4152.91694166118;4222.91554168918;4293.0340673348555;4462.64298856094;34149.829250853836;34345.31309373824;34392.6560734392;34464.827675861714;34513.654863451295;4631.421072365954;4671.813127474897;4713.34013238147;4738.455077666078;4853.0779151961015;414867;422833.8858305689;423415;424128;425019;62062.069068964;62354.37645623576;62401.68799155975;62437;62469;38657.22685546273;39368.60631393707;39416;41979.58020419757;65186;18012.459626211235;18030.27878884856;18156.818431815776;18166.545836353933;18175.818241817677;14475.565733028026;14643;14658.853411465961;14704.117752934859;14706.485273015393;20048.298309559097;20055.197792088155;20058.39824805258;20259.39221823318;20434.386968390972;7485.363744081705;7602.391808655294;7610.695572177051;7638.236176382428;7870.960645196852;972.2076507646245;1063.409807556798;1073.8550295710136;1106.303029091667;1171.1392126786805;32416.675833241836;34070;34205.48691769625;34562;34657.48013779795;1131.3890499130541;1189.9167058305836;1209.5464200924653;1214.4838443661408;1239.8512178538454;17671;17750.644987100444;17926.193321300572;18012.279508819764;18258.36095736643;616614;620108;622458;623689;625800;62115;62506.0624090639;62619;62654;62722;1450.8984371094134;1457.154850186889;1472.9337179826935;1498.6103613060682;1500.9849901500845;31918.840405797822;32910.67089329172;33205.83397082999;33237.667623323454;33296.833515832266;54335.45664543304;54962.45037549573;54998.45001550093;55087.724561376934;55151.17273240985;526558;527018;528246;528814;533866;30514.237144071576;30708.692913070583;31174;31210.531842022843;31356;51375.743121284155;51396.48603513917;51400.22899656583;52351;52521;42453.787731061144;44168.55831441644;44669.32996005128;44808.103837923714;46083.53916460927;42572;43711.78144109259;43933.317371003766;44590.55409445864;44755.32867006932;42893.356599651655;43895;43936.560634393245;44538.3319250205;47380.2892956599;38888.41667374935;39065.609343906195;39283.607163928;40070.799646001586;40125.197496050496;30684.84657576698;30693.23266918345;30724.84637576798;30788.69211307858;30940.69059309378 19:32:53 INFO - PROCESS | 3534 | |2;jquery.html;416.96455801256894;424.1295314514972;427.5382586806248;429.78295960539924;436.26707132018197;19061.904690476564;20607.587848243027;20632.17471301148;20818;21244;19863.40409787705;20328;20737.377878663665;20928.686069708965;20960.790392096074;5808.680522571268;5985.311689155759;5987.64074155552;5995.61028533144;6006.819795406145;5811.709414529278;5853.941460585383;5913.2608423947;5928.407159284058;5979.46184843364;5816.447437493432;5860;5890.175375447441;5890.293164820207;5893.823185304426;5859.710863609999;5883.264591926009;5924.7333869975955;5931.792387266425;5945.762169513214;5213.895722085537;5231.555317797992;5324.1747529133045;5347.41178470368;5373.194020896896;17663.911680441644;23795.16716914917;23796.524069518688;24186.879065604735;24258.757412425828;2600.531904257233;2623.0556999480173;2693.2862791360303;2737.2609395463314;2788.247173263228;15528.223588820627;15583.610409739735;15602.843971560253;15729.52811415648;15923.601909952227;2041.0917141871873;2052.835773138145;2089.3836318286144;2120.9697848730534;2138.3264271754347;78409.21590784076;79284.60357698174;88040.55979720125;93638.06361936362;94280;9549.522523873917;9807;9813.705588832347;9997.150242229493;10094.091531762177;12940.676483087998;13042.804357934448;13084.607461776162;13096.541621043218;13119.147255428366;8153.1846815317995;8238.258556729923;8358;8376.916230837614;8483.321334293365;8551.657933682583;8747.51888646118;8754.69358572447;8882.689105881263;8945.239654629298;3919.451276821247;4036.6367026967714;4335.046289816299;4414.492333381638;4467.977660111744;1898.6107847891149;1932.8936908469889;1950.8197540488084;2003.7896020917885;2008.9799102008792;971.6016433262329;982.975425614351;1009.0817356205818;1084.5553323137633;1087.0977089016255;20296.695549566768;20895.8955205223;20994.265200718208;21104.683429748566;21257.68113478299;1043.3479075577764;1075.473018221066;1080.9297395669414;1086.098538213297;1088.7332603512032;11163.553457861595;11613.245139065933;11745.47145378443;11800.114991375509;11931.821022684666;468602;512895;526555;572173;581861;92561;94162.52918735362;96637;98489.50755246179;99341.50329248451;1059.1632610237825;1079.4548752879746;1084.387321163556;1093.9945300273448;1112.6606385052476;17623.29506819764;18228;18492.81507184911;18718.24716878359;18787.624247515247;44450.777746112355;45080.549194507636;45153.32270015887;47261.29108063313;47614;58639.70680146572;63391;64377;64539;65050;9058.909410905806;9312.25501959828;9315.208207302185;9502.242085214257;9537.332386732862;13445.865541344852;13809.309534523032;14396.280185990869;14563.92718036403;14808;8048.758537243658;12708.491660333853;12882.162659427107;12955;12973.54592589255;12107.697307567381;12263.570775023189;12313.199642023239;12463.5014599415;12854;12644.683882903;12692.936535317263;12809;12950.546730864375;12957.22256664603;7682.193369696101;7766.145723970246;8509.319254459504;9231.630734770533;9561.235101192027;12172.878271217174;12740.872591273968;12787.424565894371;12885.871141288842;13095.279759613313 19:32:53 INFO - PROCESS | 3534 | |3;mootools.html;1531.257340190008;1538.7307221236285;1767.6376342849717;1859.5630026943675;1907.923683052678;8664.523451210182;9299.39553928995;9489.38319009264;10058.849117263248;10118.797624047524;9353.485558294291;9775.413475191493;9891.307608467392;9896.703098907044;9900.1089901909;2425.078470181333;2451.5832308507506;2474.9628755568683;2479.6280557916275;2484.1429706751233;2507.5611767940627;2566.794656427481;2567.974320256792;2571.794256459488;2572.5240830446332;2512.836665616738;2543.605741110131;2557;2558.5010922870047;2574.2792018234923;2491.1281051631963;2505.8621775802326;2516.8615726135054;2542.4279537104003;2548.2610043087666;2502.4869901670113;2507.1475698262498;2520.962185567218;2522.1676846640567;2533.493301339721;9564.808703825955;9652.662156824477;9685;9696.612135514571;9721.90278097217;5741.368449470555;5857.531397488191;5867.237259156325;5876.089206173007;5903.616264942808;3616.4936908832783;3725.7205709571617;3776.093737503007;3846.0961674006585;3865.1496670732395;1254.8933340666053;1255.2593969557913;1262.0471543984324;1297.3383574377042;1320.056159845715;13158.671033224246;13180;13234;13644;13750.518731844337;4976.730933611906;5056.418511871108;5102.540771330598;5128.538431541179;5201.29782479368;11060.778784424267;11073.889261107446;11095.223334366678;11117.944410277896;11122.55509779616;5822;5823.767049317979;5826.621269617462;5841.2990441146485;5848.561357898089;4817.373741413664;5266.683998960075;5353.38436079848;5354.196870469383;5389.649672771257;4311.568843115663;4379.781010949503;4418.734875907456;4421.137878113737;4423.402840616475;1437.6549628089183;1444.0830072903782;1453.062774510456;1475.9262036898326;1480.370842391979;1014.1835822163082;1026.8921763214905;1083.4474418046852;1087.1302957633861;1109.2567979453786;6447.70985305653;6494.675266236669;6635.767748128792;6678.83302917431;6765.255821859591;483.9032193561302;485.57027031077047;492.70930151210956;496.2407516499761;497.0655168283604;4644.16405047088;4661.230896902041;4700.764961751899;4764.6664733469015;4793.1372352976105;11682.649520514398;11878.524859005716;11880;11914.344711040803;11936.104792140624;11778.764424711459;11853.822192667118;11857.288562686093;11869.109816763777;11875;8881.73354799357;8925.509096999598;8977.7306680801;9000.684976025808;9015.77460563478;6684.364985326386;6948.096747422803;6979.232284448808;6984;7018.438524917892;11379.829302560634;11400.315981041163;11478.713032174262;11537.88462115368;11648.592299269823;11473.655790326304;11729.765404692029;11819.349935753617;11823.82264266054;11940.701482463008;8477.279431248413;8492.74521764348;8500.53247071417;8511.872321915052;8603.311735061305;9436.292278079034;9490.85763713531;9529.618815247313;9556.331056825955;9561.330706850455;8043.034835819739;8131.878021829559;8198.877016844634;8469.449485783405;8480.575971201291;8198.303144232807;8212.219839115274;8218.178182181973;8258.83482330338;8285.875711864448;7682.539047657158;7795.766127016199;7844.764657060297;7867.291943725092;7871.48835325702;5858.853528661817;5870.53035757147;5989.221401217814;6066.666333351708;6086.452219300284;5909.2908850938165;5924.022536281637;5956.612820166675;5999.1601175836295;6014.097885317063 19:32:54 INFO - PROCESS | 3534 | |4;prototype.html;359.32626325639427;360.0458784221812;365.2074997255954;366.73595011591664;368.169777152521;5842.766289348427;5919.230500035;5920.496757775589;5924.437178468039;5955.434233747787;5604.887902241952;5762.193292938981;5812.970935145329;5822.854428639286;5831.212786273863;4510.226210880302;4532.09358128374;4550.5449455054395;4569.748663823489;4581.564751348633;4566.429196350457;4570.725756454607;4579.885502862422;4589.5869371756535;4604.930926036112;4485.282354823213;4577.610903073243;4586.7477288749105;4594.081183763244;4611.608013318872;4485.304777759453;4504.567533531906;4509.210888094571;4520.847183968067;4521.389612402317;4024.678025757932;4045.7977101144825;4053.5135783706146;4065.10567675111;4075.714699971003;5600.1599760035915;5705.115707065412;5705.488045667901;5711.571632127566;5712.857428514314;5260.132078207092;5268.5521730652945;5272.947270527284;5304.973475132639;5323.041852466555;6118.694065296718;6123.693815309217;6156.630602163885;6168.691565421711;6225.9181705055835;4161.981439002082;4382.802773875183;4455.17579247837;4513.887152821173;4521.819127234907;6080.601461663798;6335.80992570219;6347.191050550617;6356.77751278703;6385.553011289258;4461.196984542748;4498.752568608693;4501.144782491317;4506.301523263899;4507.030988337523;4556.815228040733;4560.882583766998;4571.954280457219;4592.67851250416;4593.28804035375;4979.800807967713;5204.505571970657;5239.371275446971;5244.475552444725;5264.131418315935;6131.448169664663;6142.815715528542;6151.630902145886;6155.630662160195;6238.282597501255;1558.906465612067;1570.9371625135095;1571.0338142042563;1577.3611687266446;1581.549258461356;995.4972738767021;1003.8756592616171;1004.7237009822211;1011.4993078426226;1021.6271061062807;5189.820275484306;5211.097949248497;5261;5288.778712940574;5336;5509.035918714209;5516.806911758069;5575.940571291441;5633.211350410946;5638.379778224392;4981.37732783402;5223.9477605223465;5272.340957380327;5276.788928442819;5278.5513231375;2942.896413844808;2947.6904924982996;2965.229040449499;2968.881244750229;3012.2619958110404;5602.29378997109;5662.971685141548;5719.084946408555;5730.309558680199;5769.74036168365;5392.865178370494;5616.438356164433;5618.073017952074;5657.462541058593;5706.657600543981;5659.151127330933;5673.489385955284;5677.757285872058;5754.712264386764;5763.394843541451;5310.526132698597;5323.307969964035;5447.782088716407;5531.446855314436;5544.61187716856;5384.488473595002;5435.701036443033;5453.691114132659;5541.5289700375915;5572.192032155396;6349.49204063683;6502.60984340941;6575.24384695747;6594.505412094016;6647.7008534617025;4539.682222244412;4677.859664210079;4683.765811709332;4691.132140554008;4698.248280275139;6069.241344831896;6283.3402492737605;6333.20834895638;6374.713137908898;6437.227532696106;6156.569040167145;6179.177142742812;6184.948558744934;6207.782727604512;6217.813465596039;5974.581779275409;6092.725827337869;6195.473384762346;6240.344763799736;6260.248770147611;6075.27096748393;6140.372801207773;6157.261128664589;6158.599691020069;6230.314665386894;6176.258848938156;6233.812985610439;6243.531735119975;6254.155688981929;6328.398802113792;5700.546360678;5975.940240597538;5999.460048595647;6045.516358691382;6099.268087829489 19:32:54 INFO - PROCESS | 3534 | |5;yui.html;827.5986146718844;833.2084519706278;845.3068483843247;909.5134103254758;929.8279818233632;15070.246487675613;15761.763573546406;16134.596635084128;16182.109983950879;16223.51329460115;16412.917935410336;16496.25766840492;16632.66734665306;16645.250963706632;16653.66692666146;855.1533981358473;882.9867551986725;890.4301247201764;893.3791015244408;905.5019739143478;889.5685592487638;893.7586851550078;894.8612964990436;895.5477483870636;896.1934259166737;951.5289931483891;952.380952380951;953.1278879824987;953.38030280318;954.3796532254056;934.6915517879152;939.4551160326994;942.185009966381;948.7533241357228;949.4303417949244;691.2430888177438;695.7599628128288;695.7912626212167;697.6999890047277;702.1819580189074;16313.918430407772;16328.75506867398;16331.101789401579;16359.427420040241;16388.67222655552;13699.589012329647;13878.791818122636;14979.475718349915;15277.159756213403;15958.521244362571;14076.155430674193;14105;14173.787393189008;14479.203643799587;14639;4737.384140061805;4745.335653008581;4839.854804355875;4843.079814835205;4867.561919427233;85698;86634.5668271661;86979;87089.12910870873;87336.99999999936;11704.531818727326;11875.584354547722;11902.642920712393;11971.281723096643;12169.2698438094;22110.557788844453;22215.11139554432;22312.330630081124;22326.33021009372;22331.330060098222;8662.913370866338;8701.912980870111;8794.736157915273;8796.703597115089;8821.911780882238;4965.925511117336;5125.923111153335;5133.332666753298;5204.765785539584;5231.482869967743;3773.509443772292;3820.2168555446065;3878.9806050969564;3885.747426417274;3887.3974533947285;677.265911280158;689.1661090081058;691.8305015271291;699.2343383994518;729.4237552333703;813.3777660090036;832.7002279179491;835.3359079531787;853.2789792625222;861.4831101339272;10577.524011419504;11111.277766945122;11431.142664300045;11750.70623234409;12167.634970950709;824.1305422779026;843.4348986179275;845.2875220644929;874.91250874912;875.8117004843989;5202.913631633739;5413.404525502192;5485.61600687956;5536;5583.162525621189;71770.2822971774;72045.2795472049;72192.27807721961;72431.63784181046;72456;63490.68254658697;63872;63963;91526;102908;58266.7086664564;59204;68355.65822170857;82894;96937.51531242298;10329.431881246604;10465.9476702616;10544.472776360997;10658.253922225369;10721.249512534048;50465.49534504755;53219.73390133025;53548;54016.45983540114;54119.188212176065;71096.28903711104;71990.28009719835;79144.60427697825;81330;81361.59319203366;13639.113457625619;13673.589792306248;13692.178469291874;14077.648058798612;14310.069845460011;15548;15639.921800390925;15696.372145114068;16152.192390380198;16373.359648728918;15153;15249.466268680542;15368.769468457758;15822.208889555246;16408.67182656364;14095.577132685625;14375.137491750529;14746.262686865828;14759.852401475848;15052.096874187584;14528.709425811636;14566;14723.190224537753;14907.92546037263;15110.924445377703;10283.228757843042;10472.633457828939;10672.359658420519;10876;11166.1067114629;11041.889581104408;11136.38749868765;11349.432528373383;11445.828312575151;11515.942420287845 19:32:54 INFO - PROCESS | 3534 | __end_tp_report 19:32:54 INFO - PROCESS | 3534 | __start_cc_report 19:32:54 INFO - PROCESS | 3534 | _x_x_mozilla_cycle_collect,336 19:32:54 INFO - PROCESS | 3534 | __end_cc_report 19:32:54 INFO - PROCESS | 3534 | __startTimestamp1474943573990__endTimestamp 19:32:54 INFO - PROCESS | 3534 | 19:32:54 INFO - PROCESS | 3534 | ------- Summary: start ------- 19:32:54 INFO - PROCESS | 3534 | Number of tests: 6 19:32:54 INFO - PROCESS | 3534 | 19:32:54 INFO - PROCESS | 3534 | [#0] dojo.html Cycles:165 Average:5911.12 Median:6161.57 stddev:701.61 (11.4%) stddev-sans-first:674.29 19:32:54 INFO - PROCESS | 3534 | Values: 3346.2 3352.3 3360.2 3377.8 3382.1 5885.1 5934.3 5970.0 5972.9 5976.1 5923.2 5927.5 5929.2 5943.0 5951.0 5092.4 5316.5 5357.5 5437.0 5464.9 5245.7 5325.4 5342.8 5373.4 5438.3 5390.2 5414.7 5415.5 5416.1 5453.8 5463.5 5464.8 5473.7 5489.9 5521.2 5071.6 5089.9 5187.8 5378.4 5391.4 5823.4 5840.3 5852.1 5865.3 5918.6 6242.2 6286.2 6287.2 6317.6 6322.5 6163.8 6243.5 6299.6 6315.7 6367.0 5948.4 5951.2 5952.5 5971.9 6000.9 6459.1 6483.9 6496.0 6517.6 6527.5 5983.2 6156.1 6157.5 6253.5 6281.4 6366.4 6389.8 6421.4 6426.6 6437.8 6352.8 6390.4 6393.3 6400.0 6401.4 6139.7 6206.1 6224.5 6353.7 6359.1 4820.4 4822.5 4824.2 4837.7 4867.3 4281.4 4286.1 4301.2 4318.0 4318.8 5972.3 6047.1 6075.1 6114.2 6123.8 6467.7 6505.7 6516.6 6518.6 6535.9 6141.9 6154.8 6172.0 6205.0 6207.8 5301.2 5395.2 5399.6 5508.7 5509.1 6622.1 6652.9 6677.2 6688.9 6700.3 6428.6 6451.3 6478.2 6478.7 6488.4 6358.0 6411.6 6454.7 6613.1 6678.1 6327.2 6345.4 6349.8 6355.0 6356.5 6473.8 6474.5 6478.5 6498.9 6506.4 6009.6 6137.3 6214.5 6311.8 6322.1 6249.1 6279.0 6280.5 6281.4 6311.1 6242.7 6265.6 6270.0 6272.2 6274.8 6139.2 6158.6 6184.6 6318.1 6329.7 6137.2 6154.8 6161.6 6167.9 6168.0 19:32:54 INFO - PROCESS | 3534 | 19:32:54 INFO - PROCESS | 3534 | [#1] ext.html Cycles:180 Average:68161.11 Median:44339.28 stddev:141145.16 (318.3%) stddev-sans-first:141449.89 19:32:54 INFO - PROCESS | 3534 | Values: 576.3 614.9 631.4 648.4 690.8 40103.4 44855.8 45012.8 45029.0 45063.3 44510.0 44600.1 45167.5 45358.8 45504.0 7908.6 8015.1 8015.4 8042.5 8058.9 9216.0 9255.9 9296.1 9297.7 9297.9 9352.3 9357.4 9378.6 9397.9 9428.3 9284.8 9324.3 9327.3 9334.3 9335.5 9143.7 9217.2 9223.6 9230.0 9235.5 43032.1 43132.4 43203.0 43281.6 43309.1 3868.7 4152.9 4222.9 4293.0 4462.6 34149.8 34345.3 34392.7 34464.8 34513.7 4631.4 4671.8 4713.3 4738.5 4853.1 414867.0 422833.9 423415.0 424128.0 425019.0 62062.1 62354.4 62401.7 62437.0 62469.0 38657.2 39368.6 39416.0 41979.6 65186.0 18012.5 18030.3 18156.8 18166.5 18175.8 14475.6 14643.0 14658.9 14704.1 14706.5 20048.3 20055.2 20058.4 20259.4 20434.4 7485.4 7602.4 7610.7 7638.2 7871.0 972.2 1063.4 1073.9 1106.3 1171.1 32416.7 34070.0 34205.5 34562.0 34657.5 1131.4 1189.9 1209.5 1214.5 1239.9 17671.0 17750.6 17926.2 18012.3 18258.4 616614.0 620108.0 622458.0 623689.0 625800.0 62115.0 62506.1 62619.0 62654.0 62722.0 1450.9 1457.2 1472.9 1498.6 1501.0 31918.8 32910.7 33205.8 33237.7 33296.8 54335.5 54962.5 54998.5 55087.7 55151.2 526558.0 527018.0 528246.0 528814.0 533866.0 30514.2 30708.7 31174.0 31210.5 31356.0 51375.7 51396.5 51400.2 52351.0 52521.0 42453.8 44168.6 44669.3 44808.1 46083.5 42572.0 43711.8 43933.3 44590.6 44755.3 42893.4 43895.0 43936.6 44538.3 47380.3 38888.4 39065.6 39283.6 40070.8 40125.2 30684.8 30693.2 30724.8 30788.7 30940.7 19:32:54 INFO - PROCESS | 3534 | 19:32:54 INFO - PROCESS | 3534 | [#2] jquery.html Cycles:180 Average:31121.22 Median:2715.27 stddev:88022.97 (3241.8%) stddev-sans-first:88239.70 19:32:54 INFO - PROCESS | 3534 | Values: 417.0 424.1 427.5 429.8 436.3 19061.9 20607.6 20632.2 20818.0 21244.0 19863.4 20328.0 20737.4 20928.7 20960.8 5808.7 5985.3 5987.6 5995.6 6006.8 5811.7 5853.9 5913.3 5928.4 5979.5 5816.4 5860.0 5890.2 5890.3 5893.8 5859.7 5883.3 5924.7 5931.8 5945.8 5213.9 5231.6 5324.2 5347.4 5373.2 17663.9 23795.2 23796.5 24186.9 24258.8 2600.5 2623.1 2693.3 2737.3 2788.2 15528.2 15583.6 15602.8 15729.5 15923.6 2041.1 2052.8 2089.4 2121.0 2138.3 78409.2 79284.6 88040.6 93638.1 94280.0 9549.5 9807.0 9813.7 9997.2 10094.1 12940.7 13042.8 13084.6 13096.5 13119.1 8153.2 8238.3 8358.0 8376.9 8483.3 8551.7 8747.5 8754.7 8882.7 8945.2 3919.5 4036.6 4335.0 4414.5 4468.0 1898.6 1932.9 1950.8 2003.8 2009.0 971.6 983.0 1009.1 1084.6 1087.1 20296.7 20895.9 20994.3 21104.7 21257.7 1043.3 1075.5 1080.9 1086.1 1088.7 11163.6 11613.2 11745.5 11800.1 11931.8 468602.0 512895.0 526555.0 572173.0 581861.0 92561.0 94162.5 96637.0 98489.5 99341.5 1059.2 1079.5 1084.4 1094.0 1112.7 17623.3 18228.0 18492.8 18718.2 18787.6 44450.8 45080.5 45153.3 47261.3 47614.0 58639.7 63391.0 64377.0 64539.0 65050.0 9058.9 9312.3 9315.2 9502.2 9537.3 13445.9 13809.3 14396.3 14563.9 14808.0 8048.8 12708.5 12882.2 12955.0 12973.5 12107.7 12263.6 12313.2 12463.5 12854.0 12644.7 12692.9 12809.0 12950.5 12957.2 7682.2 7766.1 8509.3 9231.6 9561.2 12172.9 12740.9 12787.4 12885.9 13095.3 19:32:54 INFO - PROCESS | 3534 | 19:32:54 INFO - PROCESS | 3534 | [#3] mootools.html Cycles:180 Average:6407.23 Median:4778.90 stddev:3647.51 (76.3%) stddev-sans-first:3639.33 19:32:54 INFO - PROCESS | 3534 | Values: 1531.3 1538.7 1767.6 1859.6 1907.9 8664.5 9299.4 9489.4 10058.8 10118.8 9353.5 9775.4 9891.3 9896.7 9900.1 2425.1 2451.6 2475.0 2479.6 2484.1 2507.6 2566.8 2568.0 2571.8 2572.5 2512.8 2543.6 2557.0 2558.5 2574.3 2491.1 2505.9 2516.9 2542.4 2548.3 2502.5 2507.1 2521.0 2522.2 2533.5 9564.8 9652.7 9685.0 9696.6 9721.9 5741.4 5857.5 5867.2 5876.1 5903.6 3616.5 3725.7 3776.1 3846.1 3865.1 1254.9 1255.3 1262.0 1297.3 1320.1 13158.7 13180.0 13234.0 13644.0 13750.5 4976.7 5056.4 5102.5 5128.5 5201.3 11060.8 11073.9 11095.2 11117.9 11122.6 5822.0 5823.8 5826.6 5841.3 5848.6 4817.4 5266.7 5353.4 5354.2 5389.6 4311.6 4379.8 4418.7 4421.1 4423.4 1437.7 1444.1 1453.1 1475.9 1480.4 1014.2 1026.9 1083.4 1087.1 1109.3 6447.7 6494.7 6635.8 6678.8 6765.3 483.9 485.6 492.7 496.2 497.1 4644.2 4661.2 4700.8 4764.7 4793.1 11682.6 11878.5 11880.0 11914.3 11936.1 11778.8 11853.8 11857.3 11869.1 11875.0 8881.7 8925.5 8977.7 9000.7 9015.8 6684.4 6948.1 6979.2 6984.0 7018.4 11379.8 11400.3 11478.7 11537.9 11648.6 11473.7 11729.8 11819.3 11823.8 11940.7 8477.3 8492.7 8500.5 8511.9 8603.3 9436.3 9490.9 9529.6 9556.3 9561.3 8043.0 8131.9 8198.9 8469.4 8480.6 8198.3 8212.2 8218.2 8258.8 8285.9 7682.5 7795.8 7844.8 7867.3 7871.5 5858.9 5870.5 5989.2 6066.7 6086.5 5909.3 5924.0 5956.6 5999.2 6014.1 19:32:54 INFO - PROCESS | 3534 | 19:32:54 INFO - PROCESS | 3534 | [#4] prototype.html Cycles:180 Average:5007.21 Median:5481.36 stddev:1450.18 (26.5%) stddev-sans-first:1411.66 19:32:54 INFO - PROCESS | 3534 | Values: 359.3 360.0 365.2 366.7 368.2 5842.8 5919.2 5920.5 5924.4 5955.4 5604.9 5762.2 5813.0 5822.9 5831.2 4510.2 4532.1 4550.5 4569.7 4581.6 4566.4 4570.7 4579.9 4589.6 4604.9 4485.3 4577.6 4586.7 4594.1 4611.6 4485.3 4504.6 4509.2 4520.8 4521.4 4024.7 4045.8 4053.5 4065.1 4075.7 5600.2 5705.1 5705.5 5711.6 5712.9 5260.1 5268.6 5272.9 5305.0 5323.0 6118.7 6123.7 6156.6 6168.7 6225.9 4162.0 4382.8 4455.2 4513.9 4521.8 6080.6 6335.8 6347.2 6356.8 6385.6 4461.2 4498.8 4501.1 4506.3 4507.0 4556.8 4560.9 4572.0 4592.7 4593.3 4979.8 5204.5 5239.4 5244.5 5264.1 6131.4 6142.8 6151.6 6155.6 6238.3 1558.9 1570.9 1571.0 1577.4 1581.5 995.5 1003.9 1004.7 1011.5 1021.6 5189.8 5211.1 5261.0 5288.8 5336.0 5509.0 5516.8 5575.9 5633.2 5638.4 4981.4 5223.9 5272.3 5276.8 5278.6 2942.9 2947.7 2965.2 2968.9 3012.3 5602.3 5663.0 5719.1 5730.3 5769.7 5392.9 5616.4 5618.1 5657.5 5706.7 5659.2 5673.5 5677.8 5754.7 5763.4 5310.5 5323.3 5447.8 5531.4 5544.6 5384.5 5435.7 5453.7 5541.5 5572.2 6349.5 6502.6 6575.2 6594.5 6647.7 4539.7 4677.9 4683.8 4691.1 4698.2 6069.2 6283.3 6333.2 6374.7 6437.2 6156.6 6179.2 6184.9 6207.8 6217.8 5974.6 6092.7 6195.5 6240.3 6260.2 6075.3 6140.4 6157.3 6158.6 6230.3 6176.3 6233.8 6243.5 6254.2 6328.4 5700.5 5975.9 5999.5 6045.5 6099.3 19:32:54 INFO - PROCESS | 3534 | 19:32:54 INFO - PROCESS | 3534 | [#5] yui.html Cycles:180 Average:19599.68 Median:4916.74 stddev:25406.91 (516.7%) stddev-sans-first:25439.08 19:32:54 INFO - PROCESS | 3534 | Values: 827.6 833.2 845.3 909.5 929.8 15070.2 15761.8 16134.6 16182.1 16223.5 16412.9 16496.3 16632.7 16645.3 16653.7 855.2 883.0 890.4 893.4 905.5 889.6 893.8 894.9 895.5 896.2 951.5 952.4 953.1 953.4 954.4 934.7 939.5 942.2 948.8 949.4 691.2 695.8 695.8 697.7 702.2 16313.9 16328.8 16331.1 16359.4 16388.7 13699.6 13878.8 14979.5 15277.2 15958.5 14076.2 14105.0 14173.8 14479.2 14639.0 4737.4 4745.3 4839.9 4843.1 4867.6 85698.0 86634.6 86979.0 87089.1 87337.0 11704.5 11875.6 11902.6 11971.3 12169.3 22110.6 22215.1 22312.3 22326.3 22331.3 8662.9 8701.9 8794.7 8796.7 8821.9 4965.9 5125.9 5133.3 5204.8 5231.5 3773.5 3820.2 3879.0 3885.7 3887.4 677.3 689.2 691.8 699.2 729.4 813.4 832.7 835.3 853.3 861.5 10577.5 11111.3 11431.1 11750.7 12167.6 824.1 843.4 845.3 874.9 875.8 5202.9 5413.4 5485.6 5536.0 5583.2 71770.3 72045.3 72192.3 72431.6 72456.0 63490.7 63872.0 63963.0 91526.0 102908.0 58266.7 59204.0 68355.7 82894.0 96937.5 10329.4 10465.9 10544.5 10658.3 10721.2 50465.5 53219.7 53548.0 54016.5 54119.2 71096.3 71990.3 79144.6 81330.0 81361.6 13639.1 13673.6 13692.2 14077.6 14310.1 15548.0 15639.9 15696.4 16152.2 16373.4 15153.0 15249.5 15368.8 15822.2 16408.7 14095.6 14375.1 14746.3 14759.9 15052.1 14528.7 14566.0 14723.2 14907.9 15110.9 10283.2 10472.6 10672.4 10876.0 11166.1 11041.9 11136.4 11349.4 11445.8 11515.9 19:32:54 INFO - PROCESS | 3534 | -------- Summary: end -------- 19:32:54 INFO - PROCESS | 3534 | 19:32:54 INFO - TEST-INFO | 3534: exit 0 19:32:54 INFO - TEST-OK | dromaeo_css | took 1110965ms 19:32:54 INFO - TEST-START | kraken 19:32:54 INFO - operating with platform_type : linux_ 19:32:54 INFO - Initialising browser for kraken test... 19:32:54 INFO - TEST-INFO | started process 3780 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcIZ1a_/profile http://localhost:41571/getInfo.html) 19:32:59 INFO - PROCESS | 3780 | __metrics Screen width/height:1600/1200 19:32:59 INFO - PROCESS | 3780 | colorDepth:24 19:32:59 INFO - PROCESS | 3780 | Browser inner width/height: 1024/697 19:32:59 INFO - PROCESS | 3780 | __metrics 19:33:00 ERROR - PROCESS | 3780 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 19:33:00 INFO - TEST-INFO | 3780: exit 0 19:33:00 INFO - Browser initialized. 19:33:00 INFO - Running cycle 1/1 for kraken test... 19:33:00 INFO - TEST-INFO | started process 3902 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcIZ1a_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:33:12 INFO - PROCESS | 3902 | RSS: Main: 149610496 19:33:12 INFO - PROCESS | 3902 | 19:33:15 INFO - PROCESS | 3902 | Cycle 1(1): loaded http://localhost:41571/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41571/tests/kraken/driver.html?testName=audio-beat-detection) 19:33:15 INFO - PROCESS | 3902 | RSS: Main: 156573696 19:33:15 INFO - PROCESS | 3902 | 19:33:18 INFO - PROCESS | 3902 | Cycle 1(1): loaded http://localhost:41571/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41571/tests/kraken/driver.html?testName=audio-dft) 19:33:19 INFO - PROCESS | 3902 | RSS: Main: 156119040 19:33:19 INFO - PROCESS | 3902 | 19:33:21 INFO - PROCESS | 3902 | Cycle 1(1): loaded http://localhost:41571/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41571/tests/kraken/driver.html?testName=audio-fft) 19:33:22 INFO - PROCESS | 3902 | RSS: Main: 156106752 19:33:22 INFO - PROCESS | 3902 | 19:33:24 INFO - PROCESS | 3902 | Cycle 1(1): loaded http://localhost:41571/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41571/tests/kraken/driver.html?testName=audio-oscillator) 19:33:25 INFO - PROCESS | 3902 | RSS: Main: 156098560 19:33:25 INFO - PROCESS | 3902 | 19:33:27 INFO - PROCESS | 3902 | Cycle 1(1): loaded http://localhost:41571/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41571/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:33:28 INFO - PROCESS | 3902 | RSS: Main: 155693056 19:33:28 INFO - PROCESS | 3902 | 19:33:31 INFO - PROCESS | 3902 | Cycle 1(1): loaded http://localhost:41571/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41571/tests/kraken/driver.html?testName=imaging-darkroom) 19:33:31 INFO - PROCESS | 3902 | RSS: Main: 156004352 19:33:31 INFO - PROCESS | 3902 | 19:33:35 INFO - PROCESS | 3902 | Cycle 1(1): loaded http://localhost:41571/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41571/tests/kraken/driver.html?testName=imaging-desaturate) 19:33:35 INFO - PROCESS | 3902 | RSS: Main: 156237824 19:33:35 INFO - PROCESS | 3902 | 19:33:38 INFO - PROCESS | 3902 | Cycle 1(1): loaded http://localhost:41571/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41571/tests/kraken/driver.html?testName=json-parse-financial) 19:33:39 INFO - PROCESS | 3902 | RSS: Main: 156409856 19:33:39 INFO - PROCESS | 3902 | 19:33:40 INFO - PROCESS | 3902 | Cycle 1(1): loaded http://localhost:41571/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41571/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:33:41 INFO - PROCESS | 3902 | RSS: Main: 155250688 19:33:41 INFO - PROCESS | 3902 | 19:33:43 INFO - PROCESS | 3902 | Cycle 1(1): loaded http://localhost:41571/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41571/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:33:43 INFO - PROCESS | 3902 | RSS: Main: 155656192 19:33:43 INFO - PROCESS | 3902 | 19:33:45 INFO - PROCESS | 3902 | Cycle 1(1): loaded http://localhost:41571/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41571/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:33:46 INFO - PROCESS | 3902 | RSS: Main: 156729344 19:33:46 INFO - PROCESS | 3902 | 19:33:48 INFO - PROCESS | 3902 | Cycle 1(1): loaded http://localhost:41571/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41571/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:33:49 INFO - PROCESS | 3902 | RSS: Main: 156184576 19:33:49 INFO - PROCESS | 3902 | 19:33:52 INFO - PROCESS | 3902 | Cycle 1(1): loaded http://localhost:41571/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41571/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:33:52 INFO - PROCESS | 3902 | RSS: Main: 157167616 19:33:52 INFO - PROCESS | 3902 | 19:33:54 INFO - PROCESS | 3902 | Cycle 1(1): loaded http://localhost:41571/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41571/tests/kraken/driver.html?testName=ai-astar) 19:33:54 INFO - PROCESS | 3902 | RSS: Main: 158425088 19:33:54 INFO - PROCESS | 3902 | 19:33:54 INFO - PROCESS | 3902 | __start_tp_report 19:33:54 INFO - PROCESS | 3902 | _x_x_mozilla_page_load 19:33:54 INFO - PROCESS | 3902 | _x_x_mozilla_page_load_details 19:33:54 INFO - PROCESS | 3902 | |i|pagename|runs| 19:33:54 INFO - PROCESS | 3902 | |0;ai-astar;99;110;104;109;112;112;113;112;112;110 19:33:54 INFO - PROCESS | 3902 | |1;audio-beat-detection;143;118;139;161;119;149;151;121;185;117 19:33:54 INFO - PROCESS | 3902 | |2;audio-dft;166;165;162;162;162;166;161;160;161;161 19:33:54 INFO - PROCESS | 3902 | |3;audio-fft;74;76;76;187;77;74;74;77;162;76 19:33:54 INFO - PROCESS | 3902 | |4;audio-oscillator;84;84;155;83;86;83;140;85;83;141 19:33:54 INFO - PROCESS | 3902 | |5;imaging-gaussian-blur;117;117;117;117;117;120;121;117;121;120 19:33:54 INFO - PROCESS | 3902 | |6;imaging-darkroom;147;146;147;146;146;149;150;150;147;146 19:33:54 INFO - PROCESS | 3902 | |7;imaging-desaturate;100;95;95;95;96;96;95;99;96;95 19:33:54 INFO - PROCESS | 3902 | |8;json-parse-financial;52;52;50;51;51;51;62;53;52;51 19:33:54 INFO - PROCESS | 3902 | |9;json-stringify-tinderbox;63;63;60;60;60;59;60;61;64;60 19:33:54 INFO - PROCESS | 3902 | |10;stanford-crypto-aes;73;73;81;73;72;73;73;74;72;73 19:33:54 INFO - PROCESS | 3902 | |11;stanford-crypto-ccm;118;117;119;137;126;117;118;129;151;116 19:33:54 INFO - PROCESS | 3902 | |12;stanford-crypto-pbkdf2;149;152;150;153;153;150;152;149;153;151 19:33:54 INFO - PROCESS | 3902 | |13;stanford-crypto-sha256-iterative;62;62;63;63;62;65;60;62;63;62 19:33:54 INFO - PROCESS | 3902 | __end_tp_report 19:33:54 INFO - PROCESS | 3902 | __start_cc_report 19:33:54 INFO - PROCESS | 3902 | _x_x_mozilla_cycle_collect,872 19:33:54 INFO - PROCESS | 3902 | __end_cc_report 19:33:54 INFO - PROCESS | 3902 | __startTimestamp1474943634729__endTimestamp 19:33:54 INFO - PROCESS | 3902 | 19:33:54 INFO - PROCESS | 3902 | ------- Summary: start ------- 19:33:54 INFO - PROCESS | 3902 | Number of tests: 14 19:33:54 INFO - PROCESS | 3902 | 19:33:54 INFO - PROCESS | 3902 | [#0] ai-astar Cycles:10 Average:109.30 Median:112.00 stddev:4.45 (4.0%) stddev-sans-first:2.74 19:33:54 INFO - PROCESS | 3902 | Values: 99.0 110.0 104.0 109.0 112.0 112.0 113.0 112.0 112.0 110.0 19:33:54 INFO - PROCESS | 3902 | 19:33:54 INFO - PROCESS | 3902 | [#1] audio-beat-detection Cycles:10 Average:140.30 Median:146.00 stddev:22.34 (15.3%) stddev-sans-first:23.67 19:33:54 INFO - PROCESS | 3902 | Values: 143.0 118.0 139.0 161.0 119.0 149.0 151.0 121.0 185.0 117.0 19:33:54 INFO - PROCESS | 3902 | 19:33:54 INFO - PROCESS | 3902 | [#2] audio-dft Cycles:10 Average:162.60 Median:162.00 stddev:2.22 (1.4%) stddev-sans-first:1.99 19:33:54 INFO - PROCESS | 3902 | Values: 166.0 165.0 162.0 162.0 162.0 166.0 161.0 160.0 161.0 161.0 19:33:54 INFO - PROCESS | 3902 | 19:33:54 INFO - PROCESS | 3902 | [#3] audio-fft Cycles:10 Average:95.30 Median:76.00 stddev:42.17 (55.5%) stddev-sans-first:44.02 19:33:54 INFO - PROCESS | 3902 | Values: 74.0 76.0 76.0 187.0 77.0 74.0 74.0 77.0 162.0 76.0 19:33:54 INFO - PROCESS | 3902 | 19:33:54 INFO - PROCESS | 3902 | [#4] audio-oscillator Cycles:10 Average:102.40 Median:83.50 stddev:29.90 (35.8%) stddev-sans-first:30.97 19:33:54 INFO - PROCESS | 3902 | Values: 84.0 84.0 155.0 83.0 86.0 83.0 140.0 85.0 83.0 141.0 19:33:54 INFO - PROCESS | 3902 | 19:33:54 INFO - PROCESS | 3902 | [#5] imaging-gaussian-blur Cycles:10 Average:118.40 Median:118.50 stddev:1.84 (1.6%) stddev-sans-first:1.88 19:33:54 INFO - PROCESS | 3902 | Values: 117.0 117.0 117.0 117.0 117.0 120.0 121.0 117.0 121.0 120.0 19:33:54 INFO - PROCESS | 3902 | 19:33:54 INFO - PROCESS | 3902 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.00 stddev:1.65 (1.1%) stddev-sans-first:1.74 19:33:54 INFO - PROCESS | 3902 | Values: 147.0 146.0 147.0 146.0 146.0 149.0 150.0 150.0 147.0 146.0 19:33:54 INFO - PROCESS | 3902 | 19:33:54 INFO - PROCESS | 3902 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:95.50 stddev:1.81 (1.9%) stddev-sans-first:1.30 19:33:54 INFO - PROCESS | 3902 | Values: 100.0 95.0 95.0 95.0 96.0 96.0 95.0 99.0 96.0 95.0 19:33:54 INFO - PROCESS | 3902 | 19:33:54 INFO - PROCESS | 3902 | [#8] json-parse-financial Cycles:10 Average:52.50 Median:52.00 stddev:3.44 (6.6%) stddev-sans-first:3.64 19:33:54 INFO - PROCESS | 3902 | Values: 52.0 52.0 50.0 51.0 51.0 51.0 62.0 53.0 52.0 51.0 19:33:54 INFO - PROCESS | 3902 | 19:33:54 INFO - PROCESS | 3902 | [#9] json-stringify-tinderbox Cycles:10 Average:61.00 Median:60.50 stddev:1.70 (2.8%) stddev-sans-first:1.64 19:33:54 INFO - PROCESS | 3902 | Values: 63.0 63.0 60.0 60.0 60.0 59.0 60.0 61.0 64.0 60.0 19:33:54 INFO - PROCESS | 3902 | 19:33:54 INFO - PROCESS | 3902 | [#10] stanford-crypto-aes Cycles:10 Average:73.70 Median:73.00 stddev:2.63 (3.6%) stddev-sans-first:2.77 19:33:54 INFO - PROCESS | 3902 | Values: 73.0 73.0 81.0 73.0 72.0 73.0 73.0 74.0 72.0 73.0 19:33:54 INFO - PROCESS | 3902 | 19:33:54 INFO - PROCESS | 3902 | [#11] stanford-crypto-ccm Cycles:10 Average:124.80 Median:122.50 stddev:11.45 (9.3%) stddev-sans-first:11.88 19:33:54 INFO - PROCESS | 3902 | Values: 118.0 117.0 119.0 137.0 126.0 117.0 118.0 129.0 151.0 116.0 19:33:54 INFO - PROCESS | 3902 | 19:33:54 INFO - PROCESS | 3902 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.20 Median:152.00 stddev:1.62 (1.1%) stddev-sans-first:1.51 19:33:54 INFO - PROCESS | 3902 | Values: 149.0 152.0 150.0 153.0 153.0 150.0 152.0 149.0 153.0 151.0 19:33:54 INFO - PROCESS | 3902 | 19:33:54 INFO - PROCESS | 3902 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.40 Median:62.50 stddev:1.26 (2.0%) stddev-sans-first:1.33 19:33:54 INFO - PROCESS | 3902 | Values: 62.0 62.0 63.0 63.0 62.0 65.0 60.0 62.0 63.0 62.0 19:33:54 INFO - PROCESS | 3902 | -------- Summary: end -------- 19:33:54 INFO - PROCESS | 3902 | 19:33:55 INFO - TEST-INFO | 3902: exit 0 19:33:55 INFO - TEST-OK | kraken | took 60973ms 19:33:55 INFO - SUITE-END | took 1171s 19:33:55 INFO - Completed test suite (00:19:32) 19:33:55 INFO - javascript benchmark 19:33:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7793.058112124188, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3346.1634591352163, 3352.296017836254, 3360.1935535471493, 3377.847996840142, 3382.0868365541305, 5885.058390657496, 5934.317553481351, 5969.970150149248, 5972.910406343903, 5976.133460648203, 5923.200367950336, 5927.466528012478, 5929.169916211723, 5943.049112142058, 5950.970245148779, 5092.439831618519, 5316.494932981361, 5357.464253574651, 5436.972815135919, 5464.9180262295895, 5245.68525888446, 5325.360956685184, 5342.839714808562, 5373.408925018264, 5438.320209973754, 5390.164524498709, 5414.729263536808, 5415.458454154573, 5416.052190866602, 5453.7818487260465, 5463.508284254396, 5464.7540860661165, 5473.726313684339, 5489.890202195954, 5521.2270282160525, 5071.594272458195, 5089.872753181163, 5187.844364669028, 5378.354597448292, 5391.406945236021, 5823.359430462646, 5840.299164100293, 5852.063669812852, 5865.325487568942, 5918.556108291896, 6242.157308763304, 6286.245650521921, 6287.182666253358, 6317.557770956035, 6322.462590679797, 6163.8150855474405, 6243.469305109071, 6299.622022678654, 6315.747370105236, 6367.044943258548, 5948.40515948406, 5951.166836642873, 5952.523798096142, 5971.880562388771, 6000.939990600082, 6459.09572659828, 6483.902741458882, 6496.039485730219, 6517.608943463408, 6527.54307198501, 5983.222181116427, 6156.107364432221, 6157.507399408037, 6253.499720022387, 6281.371862813773, 6366.427021567988, 6389.808305750835, 6421.422072013448, 6426.582272152295, 6437.774677886345, 6352.841178970562, 6390.424861762371, 6393.296737358887, 6399.968000159969, 6401.423871851555, 6139.693015349215, 6206.06908963659, 6224.502039836802, 6353.714082866282, 6359.141515895295, 4820.373351464287, 4822.469528351879, 4824.228123500223, 4837.685550439211, 4867.318575399447, 4281.357796330575, 4286.142771445723, 4301.182775272689, 4318.0, 4318.805653745589, 5972.313183983811, 6047.0627052806, 6075.149479072933, 6114.174586430775, 6123.846903827351, 6467.708953097028, 6505.7397704092255, 6516.609003459807, 6518.608883467007, 6535.934640653628, 6141.907871381933, 6154.815355539341, 6171.9691401542705, 6204.968975155095, 6207.81376558704, 5301.1783173608155, 5395.163749618815, 5399.622026458111, 5508.724563771795, 5509.090999985037, 6622.10601568782, 6652.900206496906, 6677.198736151596, 6688.866222675617, 6700.262971073178, 6428.582142160744, 6451.258105317761, 6478.222613286436, 6478.70845811949, 6488.383603557654, 6357.968210159104, 6411.647359395278, 6454.67726613658, 6613.074169616161, 6678.131842860397, 6327.209098862642, 6345.365463453618, 6349.777757778455, 6354.968225158845, 6356.491480681442, 6473.77341793035, 6474.4820414365795, 6478.481721462177, 6498.870022599427, 6506.4469520091325, 6009.579329447071, 6137.315698287052, 6214.5028397727165, 6311.810645680637, 6322.051692246016, 6249.062640603764, 6279.0, 6280.466160376236, 6281.403266689657, 6311.084892690443, 6242.65665388408, 6265.56141070139, 6269.96865015672, 6272.18461599989, 6274.8431289216305, 6139.15007144351, 6158.599691020069, 6184.567080304336, 6318.052292156213, 6329.7151628175925, 6137.162486020116, 6154.846128846814, 6161.568690191643, 6167.876642467215, 6168.0439531872635], "value": 5861.400500966417, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [576.2738948924357, 614.8862460444817, 631.4064779107639, 648.432621456226, 690.7513295213726, 40103.398449023254, 44855.77572112135, 45012.77493612535, 45028.999999999956, 45063.324050139236, 44510.0, 44600.10799784002, 45167.54832451683, 45358.77320613401, 45504.0, 7908.644111015004, 8015.118336982927, 8015.4389192756535, 8042.517448953082, 8058.919410805905, 9215.95392023039, 9255.907440925606, 9296.116868897478, 9297.72106836796, 9297.860532092023, 9352.298577606673, 9357.438553686767, 9378.577963991636, 9397.906020939805, 9428.292878034175, 9284.814303713922, 9324.300677449219, 9327.253819694475, 9334.346595738267, 9335.53322333884, 9143.725688229364, 9217.170454659114, 9223.584938677775, 9230.0, 9235.492047937361, 43032.139357213, 43132.35301470481, 43203.0, 43281.567184328065, 43309.133817323476, 3868.6518213360932, 4152.91694166118, 4222.91554168918, 4293.0340673348555, 4462.64298856094, 34149.829250853836, 34345.31309373824, 34392.6560734392, 34464.827675861714, 34513.654863451295, 4631.421072365954, 4671.813127474897, 4713.34013238147, 4738.455077666078, 4853.0779151961015, 414867.0, 422833.8858305689, 423415.0, 424128.0, 425019.0, 62062.069068964, 62354.37645623576, 62401.68799155975, 62437.0, 62469.0, 38657.22685546273, 39368.60631393707, 39416.0, 41979.58020419757, 65186.0, 18012.459626211235, 18030.27878884856, 18156.818431815776, 18166.545836353933, 18175.818241817677, 14475.565733028026, 14643.0, 14658.853411465961, 14704.117752934859, 14706.485273015393, 20048.298309559097, 20055.197792088155, 20058.39824805258, 20259.39221823318, 20434.386968390972, 7485.363744081705, 7602.391808655294, 7610.695572177051, 7638.236176382428, 7870.960645196852, 972.2076507646245, 1063.409807556798, 1073.8550295710136, 1106.303029091667, 1171.1392126786805, 32416.675833241836, 34070.0, 34205.48691769625, 34562.0, 34657.48013779795, 1131.3890499130541, 1189.9167058305836, 1209.5464200924653, 1214.4838443661408, 1239.8512178538454, 17671.0, 17750.644987100444, 17926.193321300572, 18012.279508819764, 18258.36095736643, 616614.0, 620108.0, 622458.0, 623689.0, 625800.0, 62115.0, 62506.0624090639, 62619.0, 62654.0, 62722.0, 1450.8984371094134, 1457.154850186889, 1472.9337179826935, 1498.6103613060682, 1500.9849901500845, 31918.840405797822, 32910.67089329172, 33205.83397082999, 33237.667623323454, 33296.833515832266, 54335.45664543304, 54962.45037549573, 54998.45001550093, 55087.724561376934, 55151.17273240985, 526558.0, 527018.0, 528246.0, 528814.0, 533866.0, 30514.237144071576, 30708.692913070583, 31174.0, 31210.531842022843, 31356.0, 51375.743121284155, 51396.48603513917, 51400.22899656583, 52351.0, 52521.0, 42453.787731061144, 44168.55831441644, 44669.32996005128, 44808.103837923714, 46083.53916460927, 42572.0, 43711.78144109259, 43933.317371003766, 44590.55409445864, 44755.32867006932, 42893.356599651655, 43895.0, 43936.560634393245, 44538.3319250205, 47380.2892956599, 38888.41667374935, 39065.609343906195, 39283.607163928, 40070.799646001586, 40125.197496050496, 30684.84657576698, 30693.23266918345, 30724.84637576798, 30788.69211307858, 30940.69059309378], "value": 21397.31200340379, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [416.96455801256894, 424.1295314514972, 427.5382586806248, 429.78295960539924, 436.26707132018197, 19061.904690476564, 20607.587848243027, 20632.17471301148, 20818.0, 21244.0, 19863.40409787705, 20328.0, 20737.377878663665, 20928.686069708965, 20960.790392096074, 5808.680522571268, 5985.311689155759, 5987.64074155552, 5995.61028533144, 6006.819795406145, 5811.709414529278, 5853.941460585383, 5913.2608423947, 5928.407159284058, 5979.46184843364, 5816.447437493432, 5860.0, 5890.175375447441, 5890.293164820207, 5893.823185304426, 5859.710863609999, 5883.264591926009, 5924.7333869975955, 5931.792387266425, 5945.762169513214, 5213.895722085537, 5231.555317797992, 5324.1747529133045, 5347.41178470368, 5373.194020896896, 17663.911680441644, 23795.16716914917, 23796.524069518688, 24186.879065604735, 24258.757412425828, 2600.531904257233, 2623.0556999480173, 2693.2862791360303, 2737.2609395463314, 2788.247173263228, 15528.223588820627, 15583.610409739735, 15602.843971560253, 15729.52811415648, 15923.601909952227, 2041.0917141871873, 2052.835773138145, 2089.3836318286144, 2120.9697848730534, 2138.3264271754347, 78409.21590784076, 79284.60357698174, 88040.55979720125, 93638.06361936362, 94280.0, 9549.522523873917, 9807.0, 9813.705588832347, 9997.150242229493, 10094.091531762177, 12940.676483087998, 13042.804357934448, 13084.607461776162, 13096.541621043218, 13119.147255428366, 8153.1846815317995, 8238.258556729923, 8358.0, 8376.916230837614, 8483.321334293365, 8551.657933682583, 8747.51888646118, 8754.69358572447, 8882.689105881263, 8945.239654629298, 3919.451276821247, 4036.6367026967714, 4335.046289816299, 4414.492333381638, 4467.977660111744, 1898.6107847891149, 1932.8936908469889, 1950.8197540488084, 2003.7896020917885, 2008.9799102008792, 971.6016433262329, 982.975425614351, 1009.0817356205818, 1084.5553323137633, 1087.0977089016255, 20296.695549566768, 20895.8955205223, 20994.265200718208, 21104.683429748566, 21257.68113478299, 1043.3479075577764, 1075.473018221066, 1080.9297395669414, 1086.098538213297, 1088.7332603512032, 11163.553457861595, 11613.245139065933, 11745.47145378443, 11800.114991375509, 11931.821022684666, 468602.0, 512895.0, 526555.0, 572173.0, 581861.0, 92561.0, 94162.52918735362, 96637.0, 98489.50755246179, 99341.50329248451, 1059.1632610237825, 1079.4548752879746, 1084.387321163556, 1093.9945300273448, 1112.6606385052476, 17623.29506819764, 18228.0, 18492.81507184911, 18718.24716878359, 18787.624247515247, 44450.777746112355, 45080.549194507636, 45153.32270015887, 47261.29108063313, 47614.0, 58639.70680146572, 63391.0, 64377.0, 64539.0, 65050.0, 9058.909410905806, 9312.25501959828, 9315.208207302185, 9502.242085214257, 9537.332386732862, 13445.865541344852, 13809.309534523032, 14396.280185990869, 14563.92718036403, 14808.0, 8048.758537243658, 12708.491660333853, 12882.162659427107, 12955.0, 12973.54592589255, 12107.697307567381, 12263.570775023189, 12313.199642023239, 12463.5014599415, 12854.0, 12644.683882903, 12692.936535317263, 12809.0, 12950.546730864375, 12957.22256664603, 7682.193369696101, 7766.145723970246, 8509.319254459504, 9231.630734770533, 9561.235101192027, 12172.878271217174, 12740.872591273968, 12787.424565894371, 12885.871141288842, 13095.279759613313], "value": 9708.278520954085, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1531.257340190008, 1538.7307221236285, 1767.6376342849717, 1859.5630026943675, 1907.923683052678, 8664.523451210182, 9299.39553928995, 9489.38319009264, 10058.849117263248, 10118.797624047524, 9353.485558294291, 9775.413475191493, 9891.307608467392, 9896.703098907044, 9900.1089901909, 2425.078470181333, 2451.5832308507506, 2474.9628755568683, 2479.6280557916275, 2484.1429706751233, 2507.5611767940627, 2566.794656427481, 2567.974320256792, 2571.794256459488, 2572.5240830446332, 2512.836665616738, 2543.605741110131, 2557.0, 2558.5010922870047, 2574.2792018234923, 2491.1281051631963, 2505.8621775802326, 2516.8615726135054, 2542.4279537104003, 2548.2610043087666, 2502.4869901670113, 2507.1475698262498, 2520.962185567218, 2522.1676846640567, 2533.493301339721, 9564.808703825955, 9652.662156824477, 9685.0, 9696.612135514571, 9721.90278097217, 5741.368449470555, 5857.531397488191, 5867.237259156325, 5876.089206173007, 5903.616264942808, 3616.4936908832783, 3725.7205709571617, 3776.093737503007, 3846.0961674006585, 3865.1496670732395, 1254.8933340666053, 1255.2593969557913, 1262.0471543984324, 1297.3383574377042, 1320.056159845715, 13158.671033224246, 13180.0, 13234.0, 13644.0, 13750.518731844337, 4976.730933611906, 5056.418511871108, 5102.540771330598, 5128.538431541179, 5201.29782479368, 11060.778784424267, 11073.889261107446, 11095.223334366678, 11117.944410277896, 11122.55509779616, 5822.0, 5823.767049317979, 5826.621269617462, 5841.2990441146485, 5848.561357898089, 4817.373741413664, 5266.683998960075, 5353.38436079848, 5354.196870469383, 5389.649672771257, 4311.568843115663, 4379.781010949503, 4418.734875907456, 4421.137878113737, 4423.402840616475, 1437.6549628089183, 1444.0830072903782, 1453.062774510456, 1475.9262036898326, 1480.370842391979, 1014.1835822163082, 1026.8921763214905, 1083.4474418046852, 1087.1302957633861, 1109.2567979453786, 6447.70985305653, 6494.675266236669, 6635.767748128792, 6678.83302917431, 6765.255821859591, 483.9032193561302, 485.57027031077047, 492.70930151210956, 496.2407516499761, 497.0655168283604, 4644.16405047088, 4661.230896902041, 4700.764961751899, 4764.6664733469015, 4793.1372352976105, 11682.649520514398, 11878.524859005716, 11880.0, 11914.344711040803, 11936.104792140624, 11778.764424711459, 11853.822192667118, 11857.288562686093, 11869.109816763777, 11875.0, 8881.73354799357, 8925.509096999598, 8977.7306680801, 9000.684976025808, 9015.77460563478, 6684.364985326386, 6948.096747422803, 6979.232284448808, 6984.0, 7018.438524917892, 11379.829302560634, 11400.315981041163, 11478.713032174262, 11537.88462115368, 11648.592299269823, 11473.655790326304, 11729.765404692029, 11819.349935753617, 11823.82264266054, 11940.701482463008, 8477.279431248413, 8492.74521764348, 8500.53247071417, 8511.872321915052, 8603.311735061305, 9436.292278079034, 9490.85763713531, 9529.618815247313, 9556.331056825955, 9561.330706850455, 8043.034835819739, 8131.878021829559, 8198.877016844634, 8469.449485783405, 8480.575971201291, 8198.303144232807, 8212.219839115274, 8218.178182181973, 8258.83482330338, 8285.875711864448, 7682.539047657158, 7795.766127016199, 7844.764657060297, 7867.291943725092, 7871.48835325702, 5858.853528661817, 5870.53035757147, 5989.221401217814, 6066.666333351708, 6086.452219300284, 5909.2908850938165, 5924.022536281637, 5956.612820166675, 5999.1601175836295, 6014.097885317063], "value": 5039.8013199298475, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [359.32626325639427, 360.0458784221812, 365.2074997255954, 366.73595011591664, 368.169777152521, 5842.766289348427, 5919.230500035, 5920.496757775589, 5924.437178468039, 5955.434233747787, 5604.887902241952, 5762.193292938981, 5812.970935145329, 5822.854428639286, 5831.212786273863, 4510.226210880302, 4532.09358128374, 4550.5449455054395, 4569.748663823489, 4581.564751348633, 4566.429196350457, 4570.725756454607, 4579.885502862422, 4589.5869371756535, 4604.930926036112, 4485.282354823213, 4577.610903073243, 4586.7477288749105, 4594.081183763244, 4611.608013318872, 4485.304777759453, 4504.567533531906, 4509.210888094571, 4520.847183968067, 4521.389612402317, 4024.678025757932, 4045.7977101144825, 4053.5135783706146, 4065.10567675111, 4075.714699971003, 5600.1599760035915, 5705.115707065412, 5705.488045667901, 5711.571632127566, 5712.857428514314, 5260.132078207092, 5268.5521730652945, 5272.947270527284, 5304.973475132639, 5323.041852466555, 6118.694065296718, 6123.693815309217, 6156.630602163885, 6168.691565421711, 6225.9181705055835, 4161.981439002082, 4382.802773875183, 4455.17579247837, 4513.887152821173, 4521.819127234907, 6080.601461663798, 6335.80992570219, 6347.191050550617, 6356.77751278703, 6385.553011289258, 4461.196984542748, 4498.752568608693, 4501.144782491317, 4506.301523263899, 4507.030988337523, 4556.815228040733, 4560.882583766998, 4571.954280457219, 4592.67851250416, 4593.28804035375, 4979.800807967713, 5204.505571970657, 5239.371275446971, 5244.475552444725, 5264.131418315935, 6131.448169664663, 6142.815715528542, 6151.630902145886, 6155.630662160195, 6238.282597501255, 1558.906465612067, 1570.9371625135095, 1571.0338142042563, 1577.3611687266446, 1581.549258461356, 995.4972738767021, 1003.8756592616171, 1004.7237009822211, 1011.4993078426226, 1021.6271061062807, 5189.820275484306, 5211.097949248497, 5261.0, 5288.778712940574, 5336.0, 5509.035918714209, 5516.806911758069, 5575.940571291441, 5633.211350410946, 5638.379778224392, 4981.37732783402, 5223.9477605223465, 5272.340957380327, 5276.788928442819, 5278.5513231375, 2942.896413844808, 2947.6904924982996, 2965.229040449499, 2968.881244750229, 3012.2619958110404, 5602.29378997109, 5662.971685141548, 5719.084946408555, 5730.309558680199, 5769.74036168365, 5392.865178370494, 5616.438356164433, 5618.073017952074, 5657.462541058593, 5706.657600543981, 5659.151127330933, 5673.489385955284, 5677.757285872058, 5754.712264386764, 5763.394843541451, 5310.526132698597, 5323.307969964035, 5447.782088716407, 5531.446855314436, 5544.61187716856, 5384.488473595002, 5435.701036443033, 5453.691114132659, 5541.5289700375915, 5572.192032155396, 6349.49204063683, 6502.60984340941, 6575.24384695747, 6594.505412094016, 6647.7008534617025, 4539.682222244412, 4677.859664210079, 4683.765811709332, 4691.132140554008, 4698.248280275139, 6069.241344831896, 6283.3402492737605, 6333.20834895638, 6374.713137908898, 6437.227532696106, 6156.569040167145, 6179.177142742812, 6184.948558744934, 6207.782727604512, 6217.813465596039, 5974.581779275409, 6092.725827337869, 6195.473384762346, 6240.344763799736, 6260.248770147611, 6075.27096748393, 6140.372801207773, 6157.261128664589, 6158.599691020069, 6230.314665386894, 6176.258848938156, 6233.812985610439, 6243.531735119975, 6254.155688981929, 6328.398802113792, 5700.546360678, 5975.940240597538, 5999.460048595647, 6045.516358691382, 6099.268087829489], "value": 4546.785389121642, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [827.5986146718844, 833.2084519706278, 845.3068483843247, 909.5134103254758, 929.8279818233632, 15070.246487675613, 15761.763573546406, 16134.596635084128, 16182.109983950879, 16223.51329460115, 16412.917935410336, 16496.25766840492, 16632.66734665306, 16645.250963706632, 16653.66692666146, 855.1533981358473, 882.9867551986725, 890.4301247201764, 893.3791015244408, 905.5019739143478, 889.5685592487638, 893.7586851550078, 894.8612964990436, 895.5477483870636, 896.1934259166737, 951.5289931483891, 952.380952380951, 953.1278879824987, 953.38030280318, 954.3796532254056, 934.6915517879152, 939.4551160326994, 942.185009966381, 948.7533241357228, 949.4303417949244, 691.2430888177438, 695.7599628128288, 695.7912626212167, 697.6999890047277, 702.1819580189074, 16313.918430407772, 16328.75506867398, 16331.101789401579, 16359.427420040241, 16388.67222655552, 13699.589012329647, 13878.791818122636, 14979.475718349915, 15277.159756213403, 15958.521244362571, 14076.155430674193, 14105.0, 14173.787393189008, 14479.203643799587, 14639.0, 4737.384140061805, 4745.335653008581, 4839.854804355875, 4843.079814835205, 4867.561919427233, 85698.0, 86634.5668271661, 86979.0, 87089.12910870873, 87336.99999999936, 11704.531818727326, 11875.584354547722, 11902.642920712393, 11971.281723096643, 12169.2698438094, 22110.557788844453, 22215.11139554432, 22312.330630081124, 22326.33021009372, 22331.330060098222, 8662.913370866338, 8701.912980870111, 8794.736157915273, 8796.703597115089, 8821.911780882238, 4965.925511117336, 5125.923111153335, 5133.332666753298, 5204.765785539584, 5231.482869967743, 3773.509443772292, 3820.2168555446065, 3878.9806050969564, 3885.747426417274, 3887.3974533947285, 677.265911280158, 689.1661090081058, 691.8305015271291, 699.2343383994518, 729.4237552333703, 813.3777660090036, 832.7002279179491, 835.3359079531787, 853.2789792625222, 861.4831101339272, 10577.524011419504, 11111.277766945122, 11431.142664300045, 11750.70623234409, 12167.634970950709, 824.1305422779026, 843.4348986179275, 845.2875220644929, 874.91250874912, 875.8117004843989, 5202.913631633739, 5413.404525502192, 5485.61600687956, 5536.0, 5583.162525621189, 71770.2822971774, 72045.2795472049, 72192.27807721961, 72431.63784181046, 72456.0, 63490.68254658697, 63872.0, 63963.0, 91526.0, 102908.0, 58266.7086664564, 59204.0, 68355.65822170857, 82894.0, 96937.51531242298, 10329.431881246604, 10465.9476702616, 10544.472776360997, 10658.253922225369, 10721.249512534048, 50465.49534504755, 53219.73390133025, 53548.0, 54016.45983540114, 54119.188212176065, 71096.28903711104, 71990.28009719835, 79144.60427697825, 81330.0, 81361.59319203366, 13639.113457625619, 13673.589792306248, 13692.178469291874, 14077.648058798612, 14310.069845460011, 15548.0, 15639.921800390925, 15696.372145114068, 16152.192390380198, 16373.359648728918, 15153.0, 15249.466268680542, 15368.769468457758, 15822.208889555246, 16408.67182656364, 14095.577132685625, 14375.137491750529, 14746.262686865828, 14759.852401475848, 15052.096874187584, 14528.709425811636, 14566.0, 14723.190224537753, 14907.92546037263, 15110.924445377703, 10283.228757843042, 10472.633457828939, 10672.359658420519, 10876.0, 11166.1067114629, 11041.889581104408, 11136.38749868765, 11349.432528373383, 11445.828312575151, 11515.942420287845], "value": 8027.609502469952, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1497.5000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 110.0, 104.0, 109.0, 112.0, 112.0, 113.0, 112.0, 112.0, 110.0], "value": 109.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 118.0, 139.0, 161.0, 119.0, 149.0, 151.0, 121.0, 185.0, 117.0], "value": 140.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 165.0, 162.0, 162.0, 162.0, 166.0, 161.0, 160.0, 161.0, 161.0], "value": 162.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 76.0, 187.0, 77.0, 74.0, 74.0, 77.0, 162.0, 76.0], "value": 95.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 155.0, 83.0, 86.0, 83.0, 140.0, 85.0, 83.0, 141.0], "value": 102.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 120.0, 121.0, 117.0, 121.0, 120.0], "value": 118.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 147.0, 146.0, 146.0, 149.0, 150.0, 150.0, 147.0, 146.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 99.0, 96.0, 95.0], "value": 96.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 50.0, 51.0, 51.0, 51.0, 62.0, 53.0, 52.0, 51.0], "value": 52.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 60.0, 60.0, 60.0, 59.0, 60.0, 61.0, 64.0, 60.0], "value": 61.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 81.0, 73.0, 72.0, 73.0, 73.0, 74.0, 72.0, 73.0], "value": 73.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 119.0, 137.0, 126.0, 117.0, 118.0, 129.0, 151.0, 116.0], "value": 124.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 152.0, 150.0, 153.0, 153.0, 150.0, 152.0, 149.0, 153.0, 151.0], "value": 151.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 63.0, 63.0, 62.0, 65.0, 60.0, 62.0, 63.0, 62.0], "value": 62.4, "unit": "score"}]}]} 19:33:56 INFO - Return code: 0 19:33:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:33:56 ERROR - # TBPL SUCCESS # 19:33:56 INFO - Running post-action listener: _resource_record_post_action 19:33:56 INFO - [mozharness: 2016-09-27 02:33:56.073128Z] Finished run-tests step (success) 19:33:56 INFO - Running post-run listener: _resource_record_post_run 19:33:56 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 0; Write bytes: 288419840; Read time: 0; Write time: 152036 19:33:56 INFO - TinderboxPrint: CPU usage
13.2% 19:33:56 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 19:33:56 INFO - TinderboxPrint: I/O write bytes / time
288,419,840 / 152,036 19:33:56 INFO - TinderboxPrint: CPU idle
8,211.6 (86.8%) 19:33:56 INFO - TinderboxPrint: CPU user
1,198.8 (12.7%) 19:33:56 INFO - TinderboxPrint: Swap in / out
0 / 0 19:33:56 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 70107136; Read time: 0; Write time: 45772 19:33:56 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 218312704; Read time: 0; Write time: 106264 19:33:56 INFO - Running post-run listener: _upload_blobber_files 19:33:56 INFO - Blob upload gear active. 19:33:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:33:56 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 19:33:56 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'] 19:33:56 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 19:33:57 INFO - (blobuploader) - INFO - Open directory for files ... 19:33:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:33:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:33:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:33:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:33:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:33:58 INFO - (blobuploader) - INFO - Done attempting. 19:33:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:33:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:33:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:34:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:34:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:34:00 INFO - (blobuploader) - INFO - Done attempting. 19:34:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:34:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:34:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:34:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:34:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:34:05 INFO - (blobuploader) - INFO - Done attempting. 19:34:05 INFO - (blobuploader) - INFO - Iteration through files over. 19:34:05 INFO - Return code: 0 19:34:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:34:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:34:05 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2b710557c753f419b928463efd31d33e7e9538f4dd87af270ff85bff9e44a0f868e74c7b330a3eb0ec02ceb65533d5c9102d80b6b3031602b6241f4a17441c59", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/58085c431060fb88813c78755a86a88cb8f2b939cbe0ede6bd24fd08f1b2cbfd76266a13074f9aa2e287a4ec18cd5c0c980dce72a4a726bf46a9b37e8ede7835", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/96bf554127e8843c4867d3edf1fad7a0216e2926bb52fd2760d2573104091a9692183f2d37e66af39fda0176a0fa42f9013a0622bd9ae426505a39909b0a3265"} 19:34:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:34:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:34:05 INFO - Contents: 19:34:05 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2b710557c753f419b928463efd31d33e7e9538f4dd87af270ff85bff9e44a0f868e74c7b330a3eb0ec02ceb65533d5c9102d80b6b3031602b6241f4a17441c59", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/58085c431060fb88813c78755a86a88cb8f2b939cbe0ede6bd24fd08f1b2cbfd76266a13074f9aa2e287a4ec18cd5c0c980dce72a4a726bf46a9b37e8ede7835", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/96bf554127e8843c4867d3edf1fad7a0216e2926bb52fd2760d2573104091a9692183f2d37e66af39fda0176a0fa42f9013a0622bd9ae426505a39909b0a3265"} 19:34:05 INFO - Running post-run listener: copy_logs_to_upload_dir 19:34:05 INFO - Copying logs to upload dir... 19:34:05 INFO - mkdir: /builds/slave/test/build/upload/logs 19:34:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1676.369593 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 56 secs) (at 2016-09-26 19:34:05.168685) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-26 19:34:05.172576) ========= 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=7de08804244eb36560b44971000001c3-1474941967.684827-1276825723 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/2b710557c753f419b928463efd31d33e7e9538f4dd87af270ff85bff9e44a0f868e74c7b330a3eb0ec02ceb65533d5c9102d80b6b3031602b6241f4a17441c59", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/58085c431060fb88813c78755a86a88cb8f2b939cbe0ede6bd24fd08f1b2cbfd76266a13074f9aa2e287a4ec18cd5c0c980dce72a4a726bf46a9b37e8ede7835", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/96bf554127e8843c4867d3edf1fad7a0216e2926bb52fd2760d2573104091a9692183f2d37e66af39fda0176a0fa42f9013a0622bd9ae426505a39909b0a3265"} build_url:https://queue.taskcluster.net/v1/task/EDdfTcNgRSuWsa_XIhnz0A/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011305 build_url: 'https://queue.taskcluster.net/v1/task/EDdfTcNgRSuWsa_XIhnz0A/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/2b710557c753f419b928463efd31d33e7e9538f4dd87af270ff85bff9e44a0f868e74c7b330a3eb0ec02ceb65533d5c9102d80b6b3031602b6241f4a17441c59", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/58085c431060fb88813c78755a86a88cb8f2b939cbe0ede6bd24fd08f1b2cbfd76266a13074f9aa2e287a4ec18cd5c0c980dce72a4a726bf46a9b37e8ede7835", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/96bf554127e8843c4867d3edf1fad7a0216e2926bb52fd2760d2573104091a9692183f2d37e66af39fda0176a0fa42f9013a0622bd9ae426505a39909b0a3265"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-26 19:34:05.197973) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 19:34:05.198360) ========= 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=7de08804244eb36560b44971000001c3-1474941967.684827-1276825723 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004530 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 19:34:05.281102) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-26 19:34:05.281426) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-26 19:34:05.281722) ========= ========= Total master_lag: 0.17 =========