builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-047 starttime: 1471516995.15 results: success (0) buildid: 20160818004001 builduid: 282603f8c8c348ccba30882955aafaf3 revision: d23f68f5cb77934e673700bfaaaf607893a2df9b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-18 03:43:15.154818) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-18 03:43:15.155675) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-18 03:43:15.155997) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-18 03:43:15.171020) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 03:43:15.171368) ========= 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=03627c79f6bb3d1578c4a402000001ba-1471516994.737793-496500294 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-18 03:43:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 15.7M=0.001s 2016-08-18 03:43:15 (15.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.117858 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 03:43:15.306601) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 03:43:15.306929) ========= 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=03627c79f6bb3d1578c4a402000001ba-1471516994.737793-496500294 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020435 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 03:43:15.359491) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-18 03:43:15.360348) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev d23f68f5cb77934e673700bfaaaf607893a2df9b --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-aurora --rev d23f68f5cb77934e673700bfaaaf607893a2df9b --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=03627c79f6bb3d1578c4a402000001ba-1471516994.737793-496500294 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-18 03:43:15,812 truncating revision to first 12 chars 2016-08-18 03:43:15,812 Setting DEBUG logging. 2016-08-18 03:43:15,812 attempt 1/10 2016-08-18 03:43:15,812 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/d23f68f5cb77?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-18 03:43:16,928 unpacking tar archive at: mozilla-aurora-d23f68f5cb77/testing/mozharness/ program finished with exit code 0 elapsedTime=1.450072 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-18 03:43:16.830150) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-18 03:43:16.830888) ========= script_repo_revision: d23f68f5cb77934e673700bfaaaf607893a2df9b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-18 03:43:16.831844) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-18 03:43:16.832521) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-18 03:43:16.844201) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 56 secs) (at 2016-08-18 03:43:16.844505) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=03627c79f6bb3d1578c4a402000001ba-1471516994.737793-496500294 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:43:17 INFO - MultiFileLogger online at 20160818 03:43:17 in /builds/slave/test 03:43:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:43:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:43:17 INFO - {'append_to_log': False, 03:43:17 INFO - 'base_work_dir': '/builds/slave/test', 03:43:17 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:43:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:43:17 INFO - 'branch': 'Mozilla-Aurora', 03:43:17 INFO - 'buildbot_json_path': 'buildprops.json', 03:43:17 INFO - 'config_files': ('talos/linux_config.py',), 03:43:17 INFO - 'default_actions': ('clobber', 03:43:17 INFO - 'read-buildbot-config', 03:43:17 INFO - 'download-and-extract', 03:43:17 INFO - 'populate-webroot', 03:43:17 INFO - 'create-virtualenv', 03:43:17 INFO - 'install', 03:43:17 INFO - 'run-tests'), 03:43:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:43:17 INFO - 'download_minidump_stackwalk': True, 03:43:17 INFO - 'download_symbols': 'ondemand', 03:43:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:43:17 INFO - 'tooltool.py': '/tools/tooltool.py', 03:43:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:43:17 INFO - '/tools/misc-python/virtualenv.py')}, 03:43:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:43:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:43:17 INFO - 'installer_path': 'installer.exe', 03:43:17 INFO - 'log_level': 'info', 03:43:17 INFO - 'log_name': 'talos', 03:43:17 INFO - 'log_to_console': True, 03:43:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:43:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:43:17 INFO - 'opt_config_files': (), 03:43:17 INFO - 'pip_index': False, 03:43:17 INFO - 'sps_profile': False, 03:43:17 INFO - 'sps_profile_interval': 0, 03:43:17 INFO - 'suite': 'dromaeojs-e10s', 03:43:17 INFO - 'system_bits': '32', 03:43:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:43:17 INFO - 'title': 'talos-linux64-ix-047', 03:43:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:43:17 INFO - 'use_talos_json': True, 03:43:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:43:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:43:17 INFO - 'work_dir': 'build'} 03:43:17 INFO - [mozharness: 2016-08-18 10:43:17.395568Z] Running clobber step. 03:43:17 INFO - Running pre-action listener: _resource_record_pre_action 03:43:17 INFO - Running main action method: clobber 03:43:17 INFO - rmtree: /builds/slave/test/build 03:43:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:43:18 INFO - Running post-action listener: _resource_record_post_action 03:43:18 INFO - [mozharness: 2016-08-18 10:43:18.380424Z] Finished clobber step (success) 03:43:18 INFO - [mozharness: 2016-08-18 10:43:18.380527Z] Running read-buildbot-config step. 03:43:18 INFO - Running pre-action listener: _resource_record_pre_action 03:43:18 INFO - Running main action method: read_buildbot_config 03:43:18 INFO - Using buildbot properties: 03:43:18 INFO - { 03:43:18 INFO - "project": "", 03:43:18 INFO - "product": "firefox", 03:43:18 INFO - "script_repo_revision": "production", 03:43:18 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 03:43:18 INFO - "repository": "", 03:43:18 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 03:43:18 INFO - "buildid": "20160818004001", 03:43:18 INFO - "stage_platform": "linux64-pgo", 03:43:18 INFO - "basedir": "/builds/slave/test", 03:43:18 INFO - "nightly_build": "True", 03:43:18 INFO - "buildnumber": 480, 03:43:18 INFO - "slavename": "talos-linux64-ix-047", 03:43:18 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:43:18 INFO - "platform": "ubuntu64_hw", 03:43:18 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:43:18 INFO - "branch": "mozilla-aurora", 03:43:18 INFO - "repo_path": "releases/mozilla-aurora", 03:43:18 INFO - "revision": "d23f68f5cb77934e673700bfaaaf607893a2df9b", 03:43:18 INFO - "pgo_build": "True", 03:43:18 INFO - "builduid": "282603f8c8c348ccba30882955aafaf3", 03:43:18 INFO - "slavebuilddir": "test" 03:43:18 INFO - } 03:43:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/Lrz76RxxQ-CJWYAYHohH2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2. 03:43:18 INFO - Running post-action listener: _resource_record_post_action 03:43:18 INFO - [mozharness: 2016-08-18 10:43:18.383064Z] Finished read-buildbot-config step (success) 03:43:18 INFO - [mozharness: 2016-08-18 10:43:18.383153Z] Running download-and-extract step. 03:43:18 INFO - Running pre-action listener: _resource_record_pre_action 03:43:18 INFO - Running main action method: download_and_extract 03:43:18 INFO - mkdir: /builds/slave/test/build/tests 03:43:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:43:18 INFO - https://queue.taskcluster.net/v1/task/Lrz76RxxQ-CJWYAYHohH2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:43:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lrz76RxxQ-CJWYAYHohH2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:43:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lrz76RxxQ-CJWYAYHohH2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:43:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lrz76RxxQ-CJWYAYHohH2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:43:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lrz76RxxQ-CJWYAYHohH2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:43:18 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lrz76RxxQ-CJWYAYHohH2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:43:18 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:43:18 INFO - retry: Failed, sleeping 30 seconds before retrying 03:43:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lrz76RxxQ-CJWYAYHohH2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #2 03:43:48 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lrz76RxxQ-CJWYAYHohH2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:43:48 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:43:48 INFO - retry: Failed, sleeping 60 seconds before retrying 03:44:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lrz76RxxQ-CJWYAYHohH2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #3 03:44:48 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lrz76RxxQ-CJWYAYHohH2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:44:48 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:44:48 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lrz76RxxQ-CJWYAYHohH2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json! 03:44:48 INFO - Caught exception: HTTP Error 404: Not Found 03:44:48 INFO - Caught exception: HTTP Error 404: Not Found 03:44:48 INFO - Caught exception: HTTP Error 404: Not Found 03:44:48 INFO - trying https://queue.taskcluster.net/v1/task/Lrz76RxxQ-CJWYAYHohH2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:44:48 INFO - Downloading https://queue.taskcluster.net/v1/task/Lrz76RxxQ-CJWYAYHohH2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:44:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Lrz76RxxQ-CJWYAYHohH2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:44:49 INFO - Downloaded 1361 bytes. 03:44:49 INFO - Reading from file /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:44:49 INFO - Using the following test package requirements: 03:44:49 INFO - {u'common': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 03:44:49 INFO - u'cppunittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:44:49 INFO - u'firefox-50.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:44:49 INFO - u'gtest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:44:49 INFO - u'firefox-50.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:44:49 INFO - u'jittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:44:49 INFO - u'jsshell-linux-x86_64.zip'], 03:44:49 INFO - u'mochitest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:44:49 INFO - u'firefox-50.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:44:49 INFO - u'mozbase': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 03:44:49 INFO - u'reftest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:44:49 INFO - u'firefox-50.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:44:49 INFO - u'talos': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:44:49 INFO - u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:44:49 INFO - u'web-platform': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:44:49 INFO - u'firefox-50.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:44:49 INFO - u'xpcshell': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:44:49 INFO - u'firefox-50.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:44:49 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:44:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:44:49 INFO - https://queue.taskcluster.net/v1/task/Lrz76RxxQ-CJWYAYHohH2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:44:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lrz76RxxQ-CJWYAYHohH2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:44:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lrz76RxxQ-CJWYAYHohH2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:44:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lrz76RxxQ-CJWYAYHohH2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:44:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lrz76RxxQ-CJWYAYHohH2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:44:49 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lrz76RxxQ-CJWYAYHohH2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:44:49 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:44:49 INFO - retry: Failed, sleeping 30 seconds before retrying 03:45:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lrz76RxxQ-CJWYAYHohH2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #2 03:45:19 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lrz76RxxQ-CJWYAYHohH2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:45:19 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:45:19 INFO - retry: Failed, sleeping 60 seconds before retrying 03:46:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lrz76RxxQ-CJWYAYHohH2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #3 03:46:19 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lrz76RxxQ-CJWYAYHohH2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:46:19 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:46:19 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lrz76RxxQ-CJWYAYHohH2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip! 03:46:19 INFO - Caught exception: HTTP Error 404: Not Found 03:46:19 INFO - Caught exception: HTTP Error 404: Not Found 03:46:19 INFO - Caught exception: HTTP Error 404: Not Found 03:46:19 INFO - trying https://queue.taskcluster.net/v1/task/Lrz76RxxQ-CJWYAYHohH2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:46:19 INFO - Downloading https://queue.taskcluster.net/v1/task/Lrz76RxxQ-CJWYAYHohH2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:46:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Lrz76RxxQ-CJWYAYHohH2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:46:19 INFO - Downloaded 21767300 bytes. 03:46:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:46:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:46:21 INFO - Return code: 0 03:46:21 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:46:21 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')]} 03:46:21 INFO - https://queue.taskcluster.net/v1/task/Lrz76RxxQ-CJWYAYHohH2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:46:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lrz76RxxQ-CJWYAYHohH2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:46:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lrz76RxxQ-CJWYAYHohH2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:46:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lrz76RxxQ-CJWYAYHohH2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:46:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lrz76RxxQ-CJWYAYHohH2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:46:21 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lrz76RxxQ-CJWYAYHohH2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:46:21 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:46:21 INFO - retry: Failed, sleeping 30 seconds before retrying 03:46:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lrz76RxxQ-CJWYAYHohH2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #2 03:46:51 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lrz76RxxQ-CJWYAYHohH2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:46:51 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:46:51 INFO - retry: Failed, sleeping 60 seconds before retrying 03:47:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lrz76RxxQ-CJWYAYHohH2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #3 03:47:51 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lrz76RxxQ-CJWYAYHohH2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:47:51 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:47:51 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lrz76RxxQ-CJWYAYHohH2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip! 03:47:51 INFO - Caught exception: HTTP Error 404: Not Found 03:47:51 INFO - Caught exception: HTTP Error 404: Not Found 03:47:51 INFO - Caught exception: HTTP Error 404: Not Found 03:47:51 INFO - trying https://queue.taskcluster.net/v1/task/Lrz76RxxQ-CJWYAYHohH2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:47:51 INFO - Downloading https://queue.taskcluster.net/v1/task/Lrz76RxxQ-CJWYAYHohH2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:47:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Lrz76RxxQ-CJWYAYHohH2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:47:52 INFO - Downloaded 21767300 bytes. 03:47:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:47:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:47:53 INFO - Return code: 0 03:47: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')]} 03:47:53 INFO - https://queue.taskcluster.net/v1/task/Lrz76RxxQ-CJWYAYHohH2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:47:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lrz76RxxQ-CJWYAYHohH2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:47:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lrz76RxxQ-CJWYAYHohH2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:47:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lrz76RxxQ-CJWYAYHohH2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:47:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lrz76RxxQ-CJWYAYHohH2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:47:53 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lrz76RxxQ-CJWYAYHohH2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:47:53 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:47:53 INFO - retry: Failed, sleeping 30 seconds before retrying 03:48:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lrz76RxxQ-CJWYAYHohH2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #2 03:48:23 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lrz76RxxQ-CJWYAYHohH2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:48:23 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:48:23 INFO - retry: Failed, sleeping 60 seconds before retrying 03:49:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lrz76RxxQ-CJWYAYHohH2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #3 03:49:23 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lrz76RxxQ-CJWYAYHohH2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:49:23 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:49:23 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lrz76RxxQ-CJWYAYHohH2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip! 03:49:23 INFO - Caught exception: HTTP Error 404: Not Found 03:49:23 INFO - Caught exception: HTTP Error 404: Not Found 03:49:23 INFO - Caught exception: HTTP Error 404: Not Found 03:49:23 INFO - trying https://queue.taskcluster.net/v1/task/Lrz76RxxQ-CJWYAYHohH2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:49:23 INFO - Downloading https://queue.taskcluster.net/v1/task/Lrz76RxxQ-CJWYAYHohH2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:49:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Lrz76RxxQ-CJWYAYHohH2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:49:24 INFO - Downloaded 14413723 bytes. 03:49:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:49:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 03:49:24 INFO - Return code: 0 03:49:24 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')]} 03:49:24 INFO - https://queue.taskcluster.net/v1/task/Lrz76RxxQ-CJWYAYHohH2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:49:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lrz76RxxQ-CJWYAYHohH2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:49:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lrz76RxxQ-CJWYAYHohH2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:49:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lrz76RxxQ-CJWYAYHohH2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:49:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lrz76RxxQ-CJWYAYHohH2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:49:24 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lrz76RxxQ-CJWYAYHohH2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:49:24 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:49:24 INFO - retry: Failed, sleeping 30 seconds before retrying 03:49:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lrz76RxxQ-CJWYAYHohH2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #2 03:49:54 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lrz76RxxQ-CJWYAYHohH2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:49:54 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:49:54 INFO - retry: Failed, sleeping 60 seconds before retrying 03:50:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lrz76RxxQ-CJWYAYHohH2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #3 03:50:54 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lrz76RxxQ-CJWYAYHohH2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:50:54 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:50:54 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lrz76RxxQ-CJWYAYHohH2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2! 03:50:54 INFO - Caught exception: HTTP Error 404: Not Found 03:50:54 INFO - Caught exception: HTTP Error 404: Not Found 03:50:54 INFO - Caught exception: HTTP Error 404: Not Found 03:50:54 INFO - trying https://queue.taskcluster.net/v1/task/Lrz76RxxQ-CJWYAYHohH2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:50:54 INFO - Downloading https://queue.taskcluster.net/v1/task/Lrz76RxxQ-CJWYAYHohH2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:50:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Lrz76RxxQ-CJWYAYHohH2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:50:56 INFO - Downloaded 63731562 bytes. 03:50:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Lrz76RxxQ-CJWYAYHohH2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:50:56 INFO - mkdir: /builds/slave/test/properties 03:50:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:50:56 INFO - Writing to file /builds/slave/test/properties/build_url 03:50:56 INFO - Contents: 03:50:56 INFO - build_url:https://queue.taskcluster.net/v1/task/Lrz76RxxQ-CJWYAYHohH2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:50:56 INFO - Running post-action listener: _resource_record_post_action 03:50:56 INFO - Running post-action listener: set_extra_try_arguments 03:50:56 INFO - [mozharness: 2016-08-18 10:50:56.771980Z] Finished download-and-extract step (success) 03:50:56 INFO - [mozharness: 2016-08-18 10:50:56.772212Z] Running populate-webroot step. 03:50:56 INFO - Running pre-action listener: _resource_record_pre_action 03:50:56 INFO - Running main action method: populate_webroot 03:50:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:50:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:50:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:50:56 INFO - '--tppagecycles', 03:50:56 INFO - '7'], 03:50:56 INFO - 'tests': ['tsvgm']}}, 03:50:56 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:50:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:50:56 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:50:56 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:50:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:50:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:50:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:50:56 INFO - 'talos_options': ['--disable-e10s'], 03:50:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:50:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:50:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:50:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:50:56 INFO - 'talos_options': ['--disable-e10s'], 03:50:56 INFO - 'tests': ['damp', 'tps']}, 03:50:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:50:56 INFO - 'tests': ['damp', 'tps']}, 03:50:56 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:50:56 INFO - 'tests': ['dromaeo_dom']}, 03:50:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:50:56 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:50:56 INFO - 'tests': ['basic_compositor_video']}, 03:50:56 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:50:56 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:50:56 INFO - 'tests': ['a11yr', 03:50:56 INFO - 'ts_paint', 03:50:56 INFO - 'tpaint', 03:50:56 INFO - 'sessionrestore', 03:50:56 INFO - 'sessionrestore_no_auto_restore', 03:50:56 INFO - 'tabpaint']}, 03:50:56 INFO - 'other-e10s': {'tests': ['a11yr', 03:50:56 INFO - 'ts_paint', 03:50:56 INFO - 'tpaint', 03:50:56 INFO - 'sessionrestore', 03:50:56 INFO - 'sessionrestore_no_auto_restore', 03:50:56 INFO - 'tabpaint']}, 03:50:56 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:50:56 INFO - 'ts_paint', 03:50:56 INFO - 'tpaint', 03:50:56 INFO - 'sessionrestore', 03:50:56 INFO - 'sessionrestore_no_auto_restore', 03:50:56 INFO - 'tabpaint']}, 03:50:56 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:50:56 INFO - 'ts_paint', 03:50:56 INFO - 'tpaint', 03:50:56 INFO - 'sessionrestore', 03:50:56 INFO - 'sessionrestore_no_auto_restore', 03:50:56 INFO - 'tabpaint']}, 03:50:56 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:50:56 INFO - 'tests': ['a11yr', 03:50:56 INFO - 'ts_paint', 03:50:56 INFO - 'tpaint', 03:50:56 INFO - 'sessionrestore', 03:50:56 INFO - 'sessionrestore_no_auto_restore', 03:50:56 INFO - 'tabpaint']}, 03:50:56 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:50:56 INFO - 'tests': ['a11yr', 03:50:56 INFO - 'ts_paint', 03:50:56 INFO - 'tpaint', 03:50:56 INFO - 'sessionrestore', 03:50:56 INFO - 'sessionrestore_no_auto_restore', 03:50:56 INFO - 'tabpaint']}, 03:50:56 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:50:56 INFO - 'tests': ['tsvgx', 03:50:56 INFO - 'tsvgr_opacity', 03:50:56 INFO - 'tart', 03:50:56 INFO - 'tscrollx', 03:50:56 INFO - 'cart']}, 03:50:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:50:56 INFO - 'tsvgr_opacity', 03:50:56 INFO - 'tart', 03:50:56 INFO - 'tscrollx', 03:50:56 INFO - 'cart']}, 03:50:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:50:56 INFO - 'talos_options': ['--disable-e10s'], 03:50:56 INFO - 'tests': ['tp5o']}, 03:50:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:50:56 INFO - 'tests': ['tp5o']}, 03:50:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:50:56 INFO - 'talos_options': ['--disable-e10s', 03:50:56 INFO - '--xperf_path', 03:50:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:50:56 INFO - 'tests': ['tp5n']}, 03:50:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:50:56 INFO - 'talos_options': ['--xperf_path', 03:50:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:50:56 INFO - 'tests': ['tp5n']}}, 03:50:56 INFO - 'talos.zip': {'path': '', 03:50:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:50:56 INFO - Running post-action listener: _resource_record_post_action 03:50:56 INFO - [mozharness: 2016-08-18 10:50:56.789745Z] Finished populate-webroot step (success) 03:50:56 INFO - [mozharness: 2016-08-18 10:50:56.789833Z] Running create-virtualenv step. 03:50:56 INFO - Running pre-action listener: _resource_record_pre_action 03:50:56 INFO - Running main action method: create_virtualenv 03:50:56 INFO - Creating virtualenv /builds/slave/test/build/venv 03:50:56 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 03:50:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:50:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:50:56 INFO - Using real prefix '/usr' 03:50:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:50:57 INFO - Installing distribute.............................................................................................................................................................................................done. 03:50:59 INFO - Installing pip.................done. 03:50:59 INFO - Return code: 0 03:50:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:50:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:50:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:50:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:50:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:50:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:50:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:50:59 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 0x1007030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x116a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1236400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c5570>, '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 0x12c6470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12c6900>, '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': '03627c79f6bb3d1578c4a402000001ba-1471516994.737793-496500294', '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 03:50:59 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 03:50:59 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 03:50:59 INFO - Using env: {'DISPLAY': ':0', 03:50:59 INFO - 'HOME': '/home/cltbld', 03:50:59 INFO - 'LANG': 'en_US.UTF-8', 03:50:59 INFO - 'LANGUAGE': 'en_US:en', 03:50:59 INFO - 'LOGNAME': 'cltbld', 03:50:59 INFO - 'MAIL': '/var/mail/cltbld', 03:50:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:50:59 INFO - 'MOZ_NO_REMOTE': '1', 03:50:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:50:59 INFO - 'NO_EM_RESTART': '1', 03:50:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:50:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:50:59 INFO - 'PWD': '/builds/slave/test', 03:50:59 INFO - 'SHELL': '/bin/bash', 03:50:59 INFO - 'SHLVL': '1', 03:50:59 INFO - 'TERM': 'linux', 03:50:59 INFO - 'TMOUT': '86400', 03:50:59 INFO - 'USER': 'cltbld', 03:50:59 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1471516994.737793-496500294', 03:50:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:50:59 INFO - '_': '/tools/buildbot/bin/python'} 03:50:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:50:59 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 03:50:59 INFO - Cleaning up... 03:50:59 INFO - Return code: 0 03:50:59 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:50:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:50:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:50:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:50:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:50:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:50:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:50:59 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 0x1007030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x116a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1236400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c5570>, '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 0x12c6470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12c6900>, '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': '03627c79f6bb3d1578c4a402000001ba-1471516994.737793-496500294', '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 03:50:59 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 03:50:59 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 03:50:59 INFO - Using env: {'DISPLAY': ':0', 03:50:59 INFO - 'HOME': '/home/cltbld', 03:50:59 INFO - 'LANG': 'en_US.UTF-8', 03:50:59 INFO - 'LANGUAGE': 'en_US:en', 03:50:59 INFO - 'LOGNAME': 'cltbld', 03:50:59 INFO - 'MAIL': '/var/mail/cltbld', 03:50:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:50:59 INFO - 'MOZ_NO_REMOTE': '1', 03:50:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:50:59 INFO - 'NO_EM_RESTART': '1', 03:50:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:50:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:50:59 INFO - 'PWD': '/builds/slave/test', 03:50:59 INFO - 'SHELL': '/bin/bash', 03:50:59 INFO - 'SHLVL': '1', 03:50:59 INFO - 'TERM': 'linux', 03:50:59 INFO - 'TMOUT': '86400', 03:50:59 INFO - 'USER': 'cltbld', 03:50:59 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1471516994.737793-496500294', 03:50:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:50:59 INFO - '_': '/tools/buildbot/bin/python'} 03:50:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:50:59 INFO - Downloading/unpacking psutil>=3.1.1 03:50:59 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 03:50:59 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 03:50:59 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 03:50:59 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 03:50:59 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 03:50:59 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 03:51:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:51:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:51:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:51:01 INFO - Installing collected packages: psutil 03:51:01 INFO - Running setup.py install for psutil 03:51:01 INFO - building 'psutil._psutil_linux' extension 03:51:01 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 03:51:02 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 03:51:02 INFO - building 'psutil._psutil_posix' extension 03:51:02 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 03:51:02 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 03:51:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:51:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:51:02 INFO - Successfully installed psutil 03:51:02 INFO - Cleaning up... 03:51:02 INFO - Return code: 0 03:51:02 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:51: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')]} 03:51:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:51:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51: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')]} 03:51:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:51:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:02 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 0x1007030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x116a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1236400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c5570>, '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 0x12c6470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12c6900>, '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': '03627c79f6bb3d1578c4a402000001ba-1471516994.737793-496500294', '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 03:51:02 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 03:51:02 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 03:51:02 INFO - Using env: {'DISPLAY': ':0', 03:51:02 INFO - 'HOME': '/home/cltbld', 03:51:02 INFO - 'LANG': 'en_US.UTF-8', 03:51:02 INFO - 'LANGUAGE': 'en_US:en', 03:51:02 INFO - 'LOGNAME': 'cltbld', 03:51:02 INFO - 'MAIL': '/var/mail/cltbld', 03:51:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:02 INFO - 'MOZ_NO_REMOTE': '1', 03:51:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:51:02 INFO - 'NO_EM_RESTART': '1', 03:51:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:51:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:02 INFO - 'PWD': '/builds/slave/test', 03:51:02 INFO - 'SHELL': '/bin/bash', 03:51:02 INFO - 'SHLVL': '1', 03:51:02 INFO - 'TERM': 'linux', 03:51:02 INFO - 'TMOUT': '86400', 03:51:02 INFO - 'USER': 'cltbld', 03:51:02 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1471516994.737793-496500294', 03:51:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:02 INFO - '_': '/tools/buildbot/bin/python'} 03:51:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:51:02 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:51:02 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 03:51:02 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 03:51:02 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 03:51:02 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 03:51:02 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 03:51:02 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 03:51:04 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:51:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:51:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:51:04 INFO - Installing collected packages: mozsystemmonitor 03:51:04 INFO - Running setup.py install for mozsystemmonitor 03:51:04 INFO - Successfully installed mozsystemmonitor 03:51:04 INFO - Cleaning up... 03:51:04 INFO - Return code: 0 03:51:04 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:51:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:51:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:51:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:51:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:51:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1007030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x116a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1236400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c5570>, '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 0x12c6470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12c6900>, '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': '03627c79f6bb3d1578c4a402000001ba-1471516994.737793-496500294', '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 03:51:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:51:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:51:04 INFO - Using env: {'DISPLAY': ':0', 03:51:04 INFO - 'HOME': '/home/cltbld', 03:51:04 INFO - 'LANG': 'en_US.UTF-8', 03:51:04 INFO - 'LANGUAGE': 'en_US:en', 03:51:04 INFO - 'LOGNAME': 'cltbld', 03:51:04 INFO - 'MAIL': '/var/mail/cltbld', 03:51:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:04 INFO - 'MOZ_NO_REMOTE': '1', 03:51:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:51:04 INFO - 'NO_EM_RESTART': '1', 03:51:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:51:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:04 INFO - 'PWD': '/builds/slave/test', 03:51:04 INFO - 'SHELL': '/bin/bash', 03:51:04 INFO - 'SHLVL': '1', 03:51:04 INFO - 'TERM': 'linux', 03:51:04 INFO - 'TMOUT': '86400', 03:51:04 INFO - 'USER': 'cltbld', 03:51:04 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1471516994.737793-496500294', 03:51:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:04 INFO - '_': '/tools/buildbot/bin/python'} 03:51:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:51:04 INFO - Downloading/unpacking jsonschema==2.5.1 03:51:04 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 03:51:04 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 03:51:04 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 03:51:04 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 03:51:04 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 03:51:04 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 03:51:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:51:06 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:51: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 03:51: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 03:51: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 03:51: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 03:51: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 03:51: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 03:51:06 INFO - Downloading functools32-3.2.3-2.tar.gz 03:51:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:51:07 INFO - warning: no files found matching '*.txt' 03:51:07 INFO - no previously-included directories found matching 'build' 03:51:07 INFO - no previously-included directories found matching 'dist' 03:51:07 INFO - no previously-included directories found matching '.git*' 03:51:07 INFO - Installing collected packages: jsonschema, functools32 03:51:07 INFO - Running setup.py install for functools32 03:51:07 INFO - warning: no files found matching '*.txt' 03:51:07 INFO - no previously-included directories found matching 'build' 03:51:07 INFO - no previously-included directories found matching 'dist' 03:51:07 INFO - no previously-included directories found matching '.git*' 03:51:07 INFO - Successfully installed jsonschema functools32 03:51:07 INFO - Cleaning up... 03:51:07 INFO - Return code: 0 03:51:07 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:51:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:51:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:51:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:51:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:51:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:07 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 0x1007030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x116a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1236400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c5570>, '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 0x12c6470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12c6900>, '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': '03627c79f6bb3d1578c4a402000001ba-1471516994.737793-496500294', '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 03:51:07 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 03:51:07 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 03:51:07 INFO - Using env: {'DISPLAY': ':0', 03:51:07 INFO - 'HOME': '/home/cltbld', 03:51:07 INFO - 'LANG': 'en_US.UTF-8', 03:51:07 INFO - 'LANGUAGE': 'en_US:en', 03:51:07 INFO - 'LOGNAME': 'cltbld', 03:51:07 INFO - 'MAIL': '/var/mail/cltbld', 03:51:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:07 INFO - 'MOZ_NO_REMOTE': '1', 03:51:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:51:07 INFO - 'NO_EM_RESTART': '1', 03:51:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:51:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:07 INFO - 'PWD': '/builds/slave/test', 03:51:07 INFO - 'SHELL': '/bin/bash', 03:51:07 INFO - 'SHLVL': '1', 03:51:07 INFO - 'TERM': 'linux', 03:51:07 INFO - 'TMOUT': '86400', 03:51:07 INFO - 'USER': 'cltbld', 03:51:07 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1471516994.737793-496500294', 03:51:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:07 INFO - '_': '/tools/buildbot/bin/python'} 03:51:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:51:07 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:51:07 INFO - Cleaning up... 03:51:07 INFO - Return code: 0 03:51:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:51:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:51:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:51:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:51:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:51:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:07 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 0x1007030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x116a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1236400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c5570>, '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 0x12c6470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12c6900>, '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': '03627c79f6bb3d1578c4a402000001ba-1471516994.737793-496500294', '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 03:51:07 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 03:51:07 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 03:51:07 INFO - Using env: {'DISPLAY': ':0', 03:51:07 INFO - 'HOME': '/home/cltbld', 03:51:07 INFO - 'LANG': 'en_US.UTF-8', 03:51:07 INFO - 'LANGUAGE': 'en_US:en', 03:51:07 INFO - 'LOGNAME': 'cltbld', 03:51:07 INFO - 'MAIL': '/var/mail/cltbld', 03:51:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:07 INFO - 'MOZ_NO_REMOTE': '1', 03:51:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:51:07 INFO - 'NO_EM_RESTART': '1', 03:51:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:51:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:07 INFO - 'PWD': '/builds/slave/test', 03:51:07 INFO - 'SHELL': '/bin/bash', 03:51:07 INFO - 'SHLVL': '1', 03:51:07 INFO - 'TERM': 'linux', 03:51:07 INFO - 'TMOUT': '86400', 03:51:07 INFO - 'USER': 'cltbld', 03:51:07 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1471516994.737793-496500294', 03:51:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:07 INFO - '_': '/tools/buildbot/bin/python'} 03:51:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:51:07 INFO - Downloading/unpacking blobuploader==1.2.4 03:51:07 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 03:51:07 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 03:51:07 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 03:51:07 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 03:51:07 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 03:51:07 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 03:51:09 INFO - Downloading blobuploader-1.2.4.tar.gz 03:51:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:51:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:51:09 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 03:51:09 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 03:51:09 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 03:51:09 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 03:51:09 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 03:51:09 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 03:51:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:51:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:51:10 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 03:51:10 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 03:51:10 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 03:51:10 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 03:51:10 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 03:51:10 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 03:51:10 INFO - Downloading docopt-0.6.1.tar.gz 03:51:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:51:10 INFO - Installing collected packages: blobuploader, requests, docopt 03:51:10 INFO - Running setup.py install for blobuploader 03:51:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:51:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:51:10 INFO - Running setup.py install for requests 03:51:10 INFO - Running setup.py install for docopt 03:51:10 INFO - Successfully installed blobuploader requests docopt 03:51:10 INFO - Cleaning up... 03:51:10 INFO - Return code: 0 03:51:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:51:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:51:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:51:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:51:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:51:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:10 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 0x1007030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x116a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1236400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c5570>, '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 0x12c6470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12c6900>, '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': '03627c79f6bb3d1578c4a402000001ba-1471516994.737793-496500294', '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 03:51:10 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 03:51:10 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 03:51:10 INFO - Using env: {'DISPLAY': ':0', 03:51:10 INFO - 'HOME': '/home/cltbld', 03:51:10 INFO - 'LANG': 'en_US.UTF-8', 03:51:10 INFO - 'LANGUAGE': 'en_US:en', 03:51:10 INFO - 'LOGNAME': 'cltbld', 03:51:10 INFO - 'MAIL': '/var/mail/cltbld', 03:51:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:10 INFO - 'MOZ_NO_REMOTE': '1', 03:51:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:51:10 INFO - 'NO_EM_RESTART': '1', 03:51:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:51:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:10 INFO - 'PWD': '/builds/slave/test', 03:51:10 INFO - 'SHELL': '/bin/bash', 03:51:10 INFO - 'SHLVL': '1', 03:51:10 INFO - 'TERM': 'linux', 03:51:10 INFO - 'TMOUT': '86400', 03:51:10 INFO - 'USER': 'cltbld', 03:51:10 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1471516994.737793-496500294', 03:51:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:10 INFO - '_': '/tools/buildbot/bin/python'} 03:51:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:51:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:51:11 INFO - Running setup.py (path:/tmp/pip-6Sygca-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:51:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:51:11 INFO - Running setup.py (path:/tmp/pip-niElaF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:51:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:51:11 INFO - Running setup.py (path:/tmp/pip-klJ9DP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:51:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:51:11 INFO - Running setup.py (path:/tmp/pip-Zp8RLC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:51:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:51:11 INFO - Running setup.py (path:/tmp/pip-9rciyJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:51:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:51:11 INFO - Running setup.py (path:/tmp/pip-Dn2oUz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:51:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:51:11 INFO - Running setup.py (path:/tmp/pip-Phs_PW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:51:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:51:11 INFO - Running setup.py (path:/tmp/pip-3qY_tR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:51:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:51:11 INFO - Running setup.py (path:/tmp/pip-NtiooN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:51:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:51:11 INFO - Running setup.py (path:/tmp/pip-uzz6eh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:51:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:51:11 INFO - Running setup.py (path:/tmp/pip-_NsYrM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:51:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:51:11 INFO - Running setup.py (path:/tmp/pip-M6NsK3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:51:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:51:12 INFO - Running setup.py (path:/tmp/pip-chBY0R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:51:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:51:12 INFO - Running setup.py (path:/tmp/pip-8SHpVv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:51:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:51:12 INFO - Running setup.py (path:/tmp/pip-Znra4O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:51:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:51:12 INFO - Running setup.py (path:/tmp/pip-GsKsnZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:51:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:51:12 INFO - Running setup.py (path:/tmp/pip-lqDOYZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:51:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:51:12 INFO - Running setup.py install for manifestparser 03:51:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:51:12 INFO - Running setup.py install for mozcrash 03:51:12 INFO - Running setup.py install for mozdebug 03:51:12 INFO - Running setup.py install for mozdevice 03:51:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:51:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:51:12 INFO - Running setup.py install for mozfile 03:51:12 INFO - Running setup.py install for mozhttpd 03:51:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:51:13 INFO - Running setup.py install for mozinfo 03:51:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:51:13 INFO - Running setup.py install for mozInstall 03:51:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:51:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:51:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:51:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:51:13 INFO - Running setup.py install for mozleak 03:51:13 INFO - Running setup.py install for mozlog 03:51:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:51:13 INFO - Running setup.py install for moznetwork 03:51:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:51:13 INFO - Running setup.py install for mozprocess 03:51:13 INFO - Running setup.py install for mozprofile 03:51:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:51:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:51:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:51:13 INFO - Running setup.py install for mozrunner 03:51:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:51:13 INFO - Running setup.py install for mozscreenshot 03:51:13 INFO - Running setup.py install for moztest 03:51:14 INFO - Running setup.py install for mozversion 03:51:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:51:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:51:14 INFO - Cleaning up... 03:51:14 INFO - Return code: 0 03:51:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:51:14 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')]} 03:51:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:51:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:14 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')]} 03:51:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:51:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:14 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 0x1007030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x116a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1236400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c5570>, '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 0x12c6470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12c6900>, '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': '03627c79f6bb3d1578c4a402000001ba-1471516994.737793-496500294', '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 03:51:14 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 03:51:14 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 03:51:14 INFO - Using env: {'DISPLAY': ':0', 03:51:14 INFO - 'HOME': '/home/cltbld', 03:51:14 INFO - 'LANG': 'en_US.UTF-8', 03:51:14 INFO - 'LANGUAGE': 'en_US:en', 03:51:14 INFO - 'LOGNAME': 'cltbld', 03:51:14 INFO - 'MAIL': '/var/mail/cltbld', 03:51:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:14 INFO - 'MOZ_NO_REMOTE': '1', 03:51:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:51:14 INFO - 'NO_EM_RESTART': '1', 03:51:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:51:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:14 INFO - 'PWD': '/builds/slave/test', 03:51:14 INFO - 'SHELL': '/bin/bash', 03:51:14 INFO - 'SHLVL': '1', 03:51:14 INFO - 'TERM': 'linux', 03:51:14 INFO - 'TMOUT': '86400', 03:51:14 INFO - 'USER': 'cltbld', 03:51:14 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1471516994.737793-496500294', 03:51:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:14 INFO - '_': '/tools/buildbot/bin/python'} 03:51:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:51:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:51:14 INFO - Running setup.py (path:/tmp/pip-gh_GXU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:51:14 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)) 03:51:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:51:14 INFO - Running setup.py (path:/tmp/pip-UvNdP6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:51:14 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)) 03:51:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:51:14 INFO - Running setup.py (path:/tmp/pip-1E0qe7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:51:14 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)) 03:51:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:51:14 INFO - Running setup.py (path:/tmp/pip-bkaB5J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:51:14 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)) 03:51:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:51:14 INFO - Running setup.py (path:/tmp/pip-G_ubWR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:51:14 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)) 03:51:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:51:14 INFO - Running setup.py (path:/tmp/pip-cDicWJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:51:14 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)) 03:51:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:51:14 INFO - Running setup.py (path:/tmp/pip-XO6pO7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:51:14 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)) 03:51:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:51:14 INFO - Running setup.py (path:/tmp/pip-PwahoM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:51:15 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)) 03:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:51:15 INFO - Running setup.py (path:/tmp/pip-UzBLRk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:51:15 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)) 03:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:51:15 INFO - Running setup.py (path:/tmp/pip-TMdXIZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:51:15 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)) 03:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:51:15 INFO - Running setup.py (path:/tmp/pip-TwBgn5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:51:15 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)) 03:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:51:15 INFO - Running setup.py (path:/tmp/pip-Cr733D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:51:15 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)) 03:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:51:15 INFO - Running setup.py (path:/tmp/pip-Zo0Ejm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:51:15 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)) 03:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:51:15 INFO - Running setup.py (path:/tmp/pip-SS3NUk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:51:15 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)) 03:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:51:15 INFO - Running setup.py (path:/tmp/pip-JlLQ6u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:51:15 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)) 03:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:51:15 INFO - Running setup.py (path:/tmp/pip-teOKEt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:51:15 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)) 03:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:51:15 INFO - Running setup.py (path:/tmp/pip-J1BbBL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:51:15 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)) 03:51:15 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)) 03:51:15 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)) 03:51:15 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)) 03:51:15 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)) 03:51:15 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)) 03:51:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:51:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:51:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:51:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:51:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:51:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:51:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:51:17 INFO - Downloading blessings-1.6.tar.gz 03:51:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:51:17 INFO - Installing collected packages: blessings 03:51:17 INFO - Running setup.py install for blessings 03:51:17 INFO - Successfully installed blessings 03:51:17 INFO - Cleaning up... 03:51:17 INFO - Return code: 0 03:51:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:51:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:51:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:51:18 INFO - Reading from file tmpfile_stdout 03:51:18 INFO - Current package versions: 03:51:18 INFO - argparse == 1.2.1 03:51:18 INFO - blessings == 1.6 03:51:18 INFO - blobuploader == 1.2.4 03:51:18 INFO - docopt == 0.6.1 03:51:18 INFO - functools32 == 3.2.3-2 03:51:18 INFO - jsonschema == 2.5.1 03:51:18 INFO - manifestparser == 1.1 03:51:18 INFO - mozInstall == 1.12 03:51:18 INFO - mozcrash == 0.17 03:51:18 INFO - mozdebug == 0.1 03:51:18 INFO - mozdevice == 0.48 03:51:18 INFO - mozfile == 1.2 03:51:18 INFO - mozhttpd == 0.7 03:51:18 INFO - mozinfo == 0.9 03:51:18 INFO - mozleak == 0.1 03:51:18 INFO - mozlog == 3.3 03:51:18 INFO - moznetwork == 0.27 03:51:18 INFO - mozprocess == 0.23 03:51:18 INFO - mozprofile == 0.28 03:51:18 INFO - mozrunner == 6.12 03:51:18 INFO - mozscreenshot == 0.1 03:51:18 INFO - mozsystemmonitor == 0.3 03:51:18 INFO - moztest == 0.7 03:51:18 INFO - mozversion == 1.4 03:51:18 INFO - psutil == 3.1.1 03:51:18 INFO - requests == 1.2.3 03:51:18 INFO - wsgiref == 0.1.2 03:51:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:51:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:51:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:51:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:51:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:51:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:18 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 0x1007030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x116a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1236400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c5570>, '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 0x12c6470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12c6900>, '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': '03627c79f6bb3d1578c4a402000001ba-1471516994.737793-496500294', '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 03:51:18 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 03:51:18 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 03:51:18 INFO - Using env: {'DISPLAY': ':0', 03:51:18 INFO - 'HOME': '/home/cltbld', 03:51:18 INFO - 'LANG': 'en_US.UTF-8', 03:51:18 INFO - 'LANGUAGE': 'en_US:en', 03:51:18 INFO - 'LOGNAME': 'cltbld', 03:51:18 INFO - 'MAIL': '/var/mail/cltbld', 03:51:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:18 INFO - 'MOZ_NO_REMOTE': '1', 03:51:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:51:18 INFO - 'NO_EM_RESTART': '1', 03:51:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:51:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:18 INFO - 'PWD': '/builds/slave/test', 03:51:18 INFO - 'SHELL': '/bin/bash', 03:51:18 INFO - 'SHLVL': '1', 03:51:18 INFO - 'TERM': 'linux', 03:51:18 INFO - 'TMOUT': '86400', 03:51:18 INFO - 'USER': 'cltbld', 03:51:18 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1471516994.737793-496500294', 03:51:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:18 INFO - '_': '/tools/buildbot/bin/python'} 03:51:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:51:18 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)) 03:51:18 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)) 03:51:18 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)) 03:51:18 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)) 03:51:18 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)) 03:51:18 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)) 03:51:18 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)) 03:51:18 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)) 03:51:18 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)) 03:51:18 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)) 03:51:18 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)) 03:51:18 INFO - Cleaning up... 03:51:18 INFO - Return code: 0 03:51:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:51:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:51:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:51:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:51:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:51:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1007030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x116a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1236400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c5570>, '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 0x12c6470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12c6900>, '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': '03627c79f6bb3d1578c4a402000001ba-1471516994.737793-496500294', '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 03:51:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:51:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:51:18 INFO - Using env: {'DISPLAY': ':0', 03:51:18 INFO - 'HOME': '/home/cltbld', 03:51:18 INFO - 'LANG': 'en_US.UTF-8', 03:51:18 INFO - 'LANGUAGE': 'en_US:en', 03:51:18 INFO - 'LOGNAME': 'cltbld', 03:51:18 INFO - 'MAIL': '/var/mail/cltbld', 03:51:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:18 INFO - 'MOZ_NO_REMOTE': '1', 03:51:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:51:18 INFO - 'NO_EM_RESTART': '1', 03:51:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:51:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:18 INFO - 'PWD': '/builds/slave/test', 03:51:18 INFO - 'SHELL': '/bin/bash', 03:51:18 INFO - 'SHLVL': '1', 03:51:18 INFO - 'TERM': 'linux', 03:51:18 INFO - 'TMOUT': '86400', 03:51:18 INFO - 'USER': 'cltbld', 03:51:18 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1471516994.737793-496500294', 03:51:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:18 INFO - '_': '/tools/buildbot/bin/python'} 03:51:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:51:18 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:51:18 INFO - Cleaning up... 03:51:18 INFO - Return code: 0 03:51:18 INFO - Running post-action listener: _resource_record_post_action 03:51:18 INFO - Running post-action listener: _start_resource_monitoring 03:51:18 INFO - Starting resource monitoring. 03:51:18 INFO - [mozharness: 2016-08-18 10:51:18.611456Z] Finished create-virtualenv step (success) 03:51:18 INFO - [mozharness: 2016-08-18 10:51:18.611886Z] Running install step. 03:51:18 INFO - Running pre-action listener: _resource_record_pre_action 03:51:18 INFO - Running main action method: install 03:51:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:51:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:51:18 INFO - Reading from file tmpfile_stdout 03:51:18 INFO - Detecting whether we're running mozinstall >=1.0... 03:51:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:51:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:51:18 INFO - Reading from file tmpfile_stdout 03:51:18 INFO - Output received: 03:51:18 INFO - Usage: mozinstall [options] installer 03:51:18 INFO - Options: 03:51:18 INFO - -h, --help show this help message and exit 03:51:18 INFO - -d DEST, --destination=DEST 03:51:18 INFO - Directory to install application into. [default: 03:51:18 INFO - "/builds/slave/test"] 03:51:18 INFO - --app=APP Application being installed. [default: firefox] 03:51:18 INFO - mkdir: /builds/slave/test/build/application 03:51:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:51:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:51:34 INFO - Reading from file tmpfile_stdout 03:51:34 INFO - Output received: 03:51:34 INFO - /builds/slave/test/build/application/firefox/firefox 03:51:34 INFO - Running post-action listener: _resource_record_post_action 03:51:34 INFO - [mozharness: 2016-08-18 10:51:34.939224Z] Finished install step (success) 03:51:34 INFO - [mozharness: 2016-08-18 10:51:34.939503Z] Running run-tests step. 03:51:34 INFO - Running pre-action listener: _resource_record_pre_action 03:51:34 INFO - Running main action method: run_tests 03:51:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:51:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:51:34 INFO - Python 2.7.3 03:51:34 INFO - Return code: 0 03:51:34 INFO - grabbing minidump binary from tooltool 03:51:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:51:34 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 0x12c5570>, '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 0x12c6470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12c6900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:51:34 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 03:51:34 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 03:51:34 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 03:51:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:51:35 INFO - Return code: 0 03:51:35 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:51:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:51:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:51:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:51:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:51:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Lrz76RxxQ-CJWYAYHohH2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--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 03:51:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Lrz76RxxQ-CJWYAYHohH2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-047 --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 03:51:35 INFO - Using env: {'DISPLAY': ':0', 03:51:35 INFO - 'HOME': '/home/cltbld', 03:51:35 INFO - 'LANG': 'en_US.UTF-8', 03:51:35 INFO - 'LANGUAGE': 'en_US:en', 03:51:35 INFO - 'LOGNAME': 'cltbld', 03:51:35 INFO - 'MAIL': '/var/mail/cltbld', 03:51:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:51:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:51:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:35 INFO - 'MOZ_NO_REMOTE': '1', 03:51:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:51:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:51:35 INFO - 'NO_EM_RESTART': '1', 03:51:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:51:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:35 INFO - 'PWD': '/builds/slave/test', 03:51:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:51:35 INFO - 'SHELL': '/bin/bash', 03:51:35 INFO - 'SHLVL': '1', 03:51:35 INFO - 'TERM': 'linux', 03:51:35 INFO - 'TMOUT': '86400', 03:51:35 INFO - 'USER': 'cltbld', 03:51:35 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1471516994.737793-496500294', 03:51:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:35 INFO - '_': '/tools/buildbot/bin/python'} 03:51:35 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Lrz76RxxQ-CJWYAYHohH2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--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 03:51:35 INFO - mozversion application_buildid: 20160818004001 03:51:35 INFO - mozversion application_changeset: d23f68f5cb77934e673700bfaaaf607893a2df9b 03:51:35 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:51:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:51:35 INFO - mozversion application_name: Firefox 03:51:35 INFO - mozversion application_remotingname: firefox-dev 03:51:35 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:51:35 INFO - mozversion application_vendor: Mozilla 03:51:35 INFO - mozversion application_version: 50.0a2 03:51:35 INFO - mozversion platform_buildid: 20160818004001 03:51:35 INFO - mozversion platform_changeset: d23f68f5cb77934e673700bfaaaf607893a2df9b 03:51:35 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:51:35 INFO - mozversion platform_version: 50.0a2 03:51:35 INFO - using testdate: 1471517495 03:51:35 INFO - actual date: 1471517495 03:51:35 INFO - starting webserver on 'localhost:53852' 03:51:35 INFO - SUITE-START | Running 2 tests 03:51:35 INFO - TEST-START | dromaeo_css 03:51:35 INFO - operating with platform_type : linux_ 03:51:35 INFO - Initialising browser for dromaeo_css test... 03:51:35 INFO - TEST-INFO | started process 32758 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLGGtrb/profile http://localhost:53852/getInfo.html) 03:51:39 INFO - PROCESS | 32758 | __metrics Screen width/height:1600/1200 03:51:39 INFO - PROCESS | 32758 | colorDepth:24 03:51:39 INFO - PROCESS | 32758 | Browser inner width/height: 1024/697 03:51:39 INFO - PROCESS | 32758 | __metrics 03:51:40 ERROR - PROCESS | 32758 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 03:51:41 INFO - TEST-INFO | 32758: exit 0 03:51:41 INFO - Browser initialized. 03:51:41 INFO - Running cycle 1/1 for dromaeo_css test... 03:51:41 INFO - TEST-INFO | started process 419 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLGGtrb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:51:52 INFO - PROCESS | 419 | RSS: Main: 152797184 03:51:52 INFO - PROCESS | 419 | 03:52:42 INFO - PROCESS | 419 | 1471517562499 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] 03:54:50 INFO - PROCESS | 419 | Cycle 1(1): loaded http://localhost:53852/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53852/tests/dromaeo/cssquery-ext.html) 03:54:52 INFO - PROCESS | 419 | RSS: Main: 158420992 03:54:52 INFO - PROCESS | 419 | 03:57:54 INFO - PROCESS | 419 | Cycle 1(1): loaded http://localhost:53852/tests/dromaeo/cssquery-ext.html (next: http://localhost:53852/tests/dromaeo/cssquery-jquery.html) 03:57:54 INFO - PROCESS | 419 | RSS: Main: 154333184 03:57:54 INFO - PROCESS | 419 | 04:00:56 INFO - PROCESS | 419 | Cycle 1(1): loaded http://localhost:53852/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53852/tests/dromaeo/cssquery-mootools.html) 04:00:57 INFO - PROCESS | 419 | RSS: Main: 154583040 04:00:57 INFO - PROCESS | 419 | 04:03:58 INFO - PROCESS | 419 | Cycle 1(1): loaded http://localhost:53852/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53852/tests/dromaeo/cssquery-prototype.html) 04:03:59 INFO - PROCESS | 419 | RSS: Main: 153096192 04:03:59 INFO - PROCESS | 419 | 04:07:02 INFO - PROCESS | 419 | Cycle 1(1): loaded http://localhost:53852/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53852/tests/dromaeo/cssquery-yui.html) 04:07:02 INFO - PROCESS | 419 | RSS: Main: 155541504 04:07:02 INFO - PROCESS | 419 | 04:10:05 INFO - PROCESS | 419 | Cycle 1(1): loaded http://localhost:53852/tests/dromaeo/cssquery-yui.html (next: http://localhost:53852/tests/dromaeo/cssquery-dojo.html) 04:10:05 INFO - PROCESS | 419 | RSS: Main: 156000256 04:10:05 INFO - PROCESS | 419 | 04:10:05 INFO - PROCESS | 419 | __start_tp_report 04:10:05 INFO - PROCESS | 419 | _x_x_mozilla_page_load 04:10:05 INFO - PROCESS | 419 | _x_x_mozilla_page_load_details 04:10:05 INFO - PROCESS | 419 | |i|pagename|runs| 04:10:05 INFO - PROCESS | 419 | |0;dojo.html;3309.8841540546077;3351.028201821472;3353.5305057291985;3369.225078232005;3380.9830950845258;5718.542516598673;5788;5789.971050144749;5791.855203619912;5833.679147646878;5719.857003574903;5728;5728.3126024876965;5751.482366587006;5754.338251101125;5170.353705786777;5200.349956255468;5218.0607490651855;5230.450802665722;5243.764030618631;5114.539691427771;5127.384713834345;5177.249298851683;5189.169732842746;5229.294045303893;5241.161414173714;5250.133727934886;5264;5320.14877619581;5335.146376579748;5316.521513063804;5330.387005494379;5340;5341.919871201935;5360.705161216131;4967.130752118401;5059.215821547666;5210.244514545408;5223.764930578095;5318.308619879391;5689.9146512802345;5774.220480235199;5777.162311464814;5797.043487824504;5821.941780582225;6118.20463339763;6166.475849552793;6191.195144631214;6224.595401298946;6262.2798378186635;5892.705364731746;6065.332813390523;6209.348018458088;6235.563510554263;6248.625082495065;5735.139729040636;5830.533557315404;5834.949709052411;5839.124131380327;5861.912071318934;6339.288392134098;6377.23473183221;6389.520785941073;6393.424591786761;6396.872062558723;5858.882822343615;5940.702964851826;6048.818535443944;6112.663803490851;6119;6060.545459090497;6114.723190878713;6122.6727265478185;6124.908126378108;6221.471174950089;6132.141500189977;6151.477124444473;6177.69111544421;6198.81403557894;6199.194104766351;6111.724972376165;6195.783147589813;6211.9068213976825;6217.160683307786;6219.346968568326;4534.274516077412;4567.81728730847;4617.561331673553;4633.7683115844075;4725.243960966229;4188.246115699142;4188.455500784939;4191.937120943188;4195.391668208093;4206.789660516962;5871.530277577784;5877.089051197071;5881.264841894763;5882.3529411764675;5887.087501437284;5940.376260492672;6112.321110680095;6121.940772762995;6142.8057410146475;6282;5903.704814759245;5943.881122377528;5945.613535120204;5952.136940143741;5990.460858522754;5022.070916880389;5172.508611681884;5181.740912954338;5182.222666600041;5187.896242075213;6211.65835879031;6330.208723909512;6339.714712837934;6464.41820236181;6472.385123413268;6262.34245404226;6262.373762623702;6271.874562508633;6276.6547839869245;6279.497640188682;6116.8227554565365;6423.871522569616;6482.57863238888;6486.870262594816;6498.512611554058;5953.523718102455;6074.119252708421;6089.665068421279;6132.049532322497;6132.448079672851;6214.5028397727165;6216.098665693358;6236.937630623817;6237.345078766845;6246.968765156327;5835.883282334415;6095.664738439251;6102.786402476069;6103.572749907464;6111.052786818051;5918.852028699317;5961.165436838759;6025.638461692312;6059.787907423219;6099.298580663103;5983.132445795248;6007.219061521974;6028.668423236764;6037.879242415039;6040.546958978006;5890;6046.4255895691595;6146.6004709693725;6148.016317389196;6148.1085242640465;5839.912401314069;5886.6173698709445;5928.229330187048;5985.730642121202;6014.548908831767 04:10:05 INFO - PROCESS | 419 | |1;ext.html;614.5329549542347;649.5777744466097;661.348571656918;687.3058211206683;725.176924191043;40817.59182408175;45648.3152752709;45885.7705711471;45980.77009614956;46310.76844615777;45775.08449831001;46004.309935351;46012.769936150275;46182.76908615461;46295;9033.187013168814;9174.311926605531;9178.449293042406;9180.081991800833;9212.815743685122;9098.909010909905;9211.815763684723;9269.721908342726;9306.255499560019;9309.767255818591;9287.674931377403;9321.673741419052;9327.113924177227;9333.53332333384;9337.393069450498;9189.218916392114;9254.676086336945;9259.537023148849;9268.721938341827;9280.396774209723;9142.908570914273;9189.81620367589;9208.217301529377;9217.493037882914;9239.353245272767;43906;44463.33305000428;44506.33240501395;44579.77710111461;44706;4010.218007488541;4147.771872547009;4536.7504787236685;4671.04243630055;4748.38271024768;34533.4819977698;34581.65418345809;35093.29813403718;35343;35823.82088089569;3884.76691398517;3887.786171760552;3920.0787814863484;3925.3326934421216;4017.0760725033406;326679;326783;327548;329909;329938;37318.62681373206;64161.67919160468;64343.356566434675;64377.356226438074;64385.35614643794;38699;40711.59288407078;40847.795761021596;40960.1807963839;40980.79509602433;16293.59266018359;16427.260773265232;16448.75326870098;16472;16529;12652.493900243888;13108.868911310765;13122.081454298299;13168.802467962989;13220.669483262804;9138.406003609743;9282.767930801783;9296.95351523238;9322.86015709765;9376;3531.805750683686;3532.3994920863515;3578.534790477221;3607.6753092221825;3610.3862343401684;1084.2247792828166;1093.9398333091756;1135.6536256441864;1176.264834478451;1191.93444360561;32870.67129328724;33444;33456.330873382394;33496;33682.15794605154;1146.1804809561204;1169.3042639629407;1170.2861254634665;1184.4551506307196;1200.4417945655312;17650.205740741698;17759.289628414717;17829.7325540117;17862.910685446488;17987.910060449613;612777;619176;621272;621281;623241;62687;62868.371316286255;63507;63541.68229158917;63913.04130438047;1464.8828093752688;1465.6775509387917;1473.1897456398938;1481.585156156278;1510.8366557750471;32931.67068329286;32974.5053824188;33293;33348.9882588059;34233.486497702055;56673.43326566681;57079.71460142673;57082.7145864268;57158.42841571531;57195.42804572068;481708;484665;485049;485544;485988;30475;30968;31156.688433116284;31285.06144815659;31393;51077.489225107274;51607.48392516177;52060;52154.21768673397;53334.73332633312;44555;44945.32582011207;45393;46130.308045378675;46491.76754116208;44192.33711494395;44841.77579112084;45142.77428612836;46359.768201158775;46774.53225467838;40414.59585404109;43842.342364863915;44437;45175.32237016382;46480.302795458774;39704.40443393409;39882.40176397299;40227.3965890506;40586.594134059465;41174.79412602918;28700.282492937007;29016.854915725286;29244;29531;29938.70061299359 04:10:05 INFO - PROCESS | 419 | |2;jquery.html;407.82463540677514;413.10562631901934;422.8541153302111;429.7035045818385;438.10626322302505;19281.614367712657;20230.39308820736;21013.894930525326;21060.36818895432;21132.366029019115;16330.51008469745;19270.71093933592;19585.804141958575;19822.70265946012;20566.48583785406;5237.162054071349;5432.945670543283;5443.8094666686675;5458.399576046631;5463.863403414906;4133.359329303963;5409.7295135243085;5417.160340147264;5428.294321738188;6613.041109039186;6650.733970641193;6670.866582668344;6678.365555272241;6680.465562754968;6689.130413046297;6575.671216439183;6627.933720662804;6649.93350066498;6698.799036028927;6700.3969642732145;5863.325717542494;5878.882422351529;5908.084246941731;5909.527237820964;5931.6441013539325;13765.931170344084;14020.92989535056;22086.233101351852;23001.309960701205;23852.761472385402;2649.576067829157;2711.91864244073;3119.313750974782;3146.57521234635;3156.384505021522;10006.799864002753;10102.09081182697;10291.691249262534;12882.291473968928;14762.778558321634;1919.7696276446916;1984.5688832325764;2017.778044415113;2050.015992323693;2072.2332736887447;79872;81131.62287233495;81971.59014204891;83991.99999999939;84171;10532.473376331152;10693.41186234749;10812.67561973142;11003.724906877393;11320.886791132149;15256.771148432783;15388.30752616135;15396.230188490754;15411.614709632124;15412.383504659912;7942.483738557091;8263.545504997162;8269;8347.54088525137;8398.748037558884;8048.959755201186;8077.515349079074;8086.636101375452;8201.343892488587;8228.465149765247;4570.520095390003;4616.792244349012;4659.347691323217;4680.204365257914;4716.504766999485;1898.2976298769543;1954.189011560215;1956.0708663384778;1996.5707372914603;2015.0932080563805;986.2553771902168;1000.6097621927454;1003.8243307421318;1006.1799633298838;1028.861103750999;19517.576701510556;19735.309264175972;19847.801521984595;20025;20510.282140125324;1018.2821111116644;1028.4806172882795;1079.5735684404774;1088.7169335972703;1131.971700707489;10549.789004220027;11298.152638552141;11369.658910232707;11370.715732106599;11407.771844563062;386408;387305;387811;557140;561471;62009;63299.6835015822;87814.56092719495;91161;102901.48549257356;1062.150279776176;1062.8246339354075;1093.8085834978688;1094.518411898778;1107.4186052322434;18118.27526898909;18480.16839242264;18628.348007819663;18725.344612938483;18798.718019229447;43178.56821431871;43436.78281608572;43482.56517434785;43957;44559.55440445684;60758.69620651868;61743.6912815433;62201.68899155475;63126.36873631205;63877.36122638714;8545.145485451405;8600.053994060523;8615.784605384915;8674.869876951725;8739.563021848755;12991.090623656253;13089.345532723517;13202.207867527979;13972.510962116277;14319.069260498034;11815.232009919328;11993.700157496132;12134.211276267015;12214.694632634255;12262.325572093621;11746.882531174579;12051.397430128634;12205.87794122083;12221.572244971383;12321.568745093879;12325.876741232472;12479.31363775001;12569.811452828399;12634.305113218861;12726.109172357847;8320.459170153921;8535.786605334917;8539.40224184326;8800.515971621366;8884.333674974532;11951.103667225167;12115.515379385079;12202.450889709808;12237.571684991339;12681.93659031699 04:10:05 INFO - PROCESS | 419 | |3;mootools.html;1502.376513746795;1543.7993060902083;1691.8815682902193;1823.9056566060358;1838.6138910828734;8302.95848520758;8823.205911467967;9133.315001374891;9355.204807591363;9385.343025988184;9215.078492150782;9442.150206481416;9491.430514169155;9499.192568631657;9500;2454.607262837942;2467.9753202468014;2486.29140694902;2487.7139129000216;2497.063601149569;2413.710354757423;2511.3219430753684;2512.4975004998983;2514.9497010059786;2520.9495810083786;2484.9006039758387;2494.675692160026;2517.7230504644476;2519.8110141739353;2522.293757747824;2412.662227288181;2430.2466235467064;2439.658447817307;2440.487497625501;2442.120836498859;2387.069043073203;2393.8324317297797;2395.808335333169;2425.9447140493767;2434.330559096245;9484.099010593982;9640.08419200182;9676.080772326617;9689.563969621384;9693.854592181053;5627.831165065014;5751.3961034091235;5765.884682306372;5776.566757493163;5784.8843023139725;3538.292341531678;3562.447820587813;3589.94615080774;3638.727095467824;3699.5005674233903;1095.5672509358837;1100.1100110011005;1109.1459576126417;1188.7147084699695;1192.1893112683372;13171.143875648053;13290.136141150795;13291.468341266338;13310.667233319147;13326.933365333209;4851.102546028996;4896.2655601660035;4952.405711314594;5005.874853128701;5105.285260063594;11251.774964500664;11291.040261577693;11324.773504529863;11377.2604780689;11384.886151138548;5765.711714414347;5779.508741756914;5780.913286300709;5805.303363596396;5821.592488525763;4708.293755936568;5217.8173763918085;5296.867578310496;5323.893522129613;5324.201369794562;4258.148370325947;4327.17783621111;4375.824967001348;4380.364847097153;4423.270160423494;1268.517963173988;1269.238456925837;1270.5426046623209;1272.783318583633;1285.3252042677668;1020.3163880200284;1063.1335461598771;1076.1659713721929;1088.4068182840372;1097.2922465010024;6226.688665566703;6263.718132683949;6446.7421303148285;6563.310852360433;6766.424853887376;1049.6221360310283;1097.8682558092921;1098.0501865885951;1115.5426275227119;1167.7430965187646;4624.28323609841;4703.7883295251795;4768.523147685273;4777.948851252719;4977.601791856643;11790.587329443428;11822;11954.342511161796;11999.940000299943;12106.81839772404;11768.35274059935;11804.940975295069;11821.586244481574;11827.112966527546;11900.940495297642;8273.8345233095;8522.27560657351;8580.14198580137;8722.215000649845;8806.779830504289;6786.423154031962;6873.072135261676;6900.723971041102;6942.722291108299;6968.338007889242;10814.675559733221;11029.283096598696;11187;11287.661370158909;11434.08527317796;11209;11214.215004949901;11410.600628977945;11464.140189485988;11551.711207219887;8394.328453723565;8424.705135320235;8448.66205351779;8451.492910425393;8462.449940753831;9149.817003660022;9162.450252984576;9190.954045229731;9224.815503690023;9249.028851970446;8013.118556958613;8054.23484768946;8114;8119.878201826859;8422.831543368975;8280.089190189196;8457.154284571494;8489.151084891462;8491.5329656867;8527.18991695788;7717.459777815499;7737.226277372218;7742.264484873928;7769.92230077692;7777.92222077772;5583.385827559046;5752.942470575241;5863.091220860773;5958.851028724143;5999.160117583455;5641.689707066151;5641.971790141023;5730.656160630376;5747.597668163356;5813.563982701399 04:10:05 INFO - PROCESS | 419 | |4;prototype.html;337.3910092283428;337.3977450251302;343.9380911435942;346.52179991611587;347.4544964405884;5762.510186634136;5815.709214539277;5836.7450998035365;5849.707514624268;5861.3552509224055;5652.406497317774;5659.207710920464;5728.22668939693;5741.684207368604;5780.50865676418;4286.807093680784;4327.978360108195;4424.756638384888;4454.8886277842985;4459.643228541725;4404.757738324391;4436.2458382074965;4437.778111094449;4448.95449569351;4463.821447142127;4405.295152775557;4421.833301682169;4426.490953540336;4431.335299705038;4440.156370289635;4293.871183864473;4392.450943632046;4415.536368681291;4424.3142312941545;4443.711158774701;3903.238868420659;3912.56961734209;3912.921741565181;3914.921701565981;3927.273454410943;5560.221568980346;5574.637648552872;5598.188262701886;5611.186377975211;5632.887342253173;4837.298591704183;5007.84976450707;5058.848234552969;5066.113430149709;5102.474275233746;5952.880942381128;5996.610220335708;6004.219451471325;6009.218801555813;6037.426444487766;4223.873283801491;4227.266820603538;4239.724417912826;4253.468316460442;4253.595908388698;6091;6224.284207316171;6277.52918531112;6290.937090629081;6298.527610429236;4306.698531102856;4325.870223893288;4334.241507736134;4336.262835318003;4340.956590434055;4360.345948107809;4371.890702732394;4378.627816635558;4381.298992161239;4391.341298805205;4915.729634870117;5037.319961805109;5040.621953353513;5047.772850221675;5068.341115654941;6012.7294271757;6051.152838602599;6063.787767428119;6069.544784141207;6070.696465176812;1459.3797636004656;1482.0662982321069;1514.258013573341;1529.3041666041925;1530.4566878758103;923.8244733500613;960.5293406231036;967.6806653804368;986.5954958466995;1010.9646162384281;5783.797567085132;5799.5650326225705;5834.533237341087;5842;5856.8535786604825;6204.503639708812;6205.162303089025;6210.254769427697;6211.409916058057;6233.875322493524;5629.127485239795;5851.941480585225;5888.9705551472825;5909.202257695242;5949.940500595025;3283.7537184710764;3321.983390083034;3332.8333583320737;3342.8495717692763;3344.2308269097757;6265;6417.711202995876;6451.258105317855;6504.707288172043;6529.15121034272;6263.96868015657;6293.96853015732;6300.401461861115;6331.461825744771;6351.17434733491;6239.344868788712;6444.967775161094;6453.6121634994415;6456.806295811133;6506;6208.627482350893;6254.718537665907;6288.182536270256;6293.590916590407;6309.179806625109;6213.440790328892;6223;6231.813045608639;6234.657093859882;6254.6247225166635;6320.683965801783;6422.916999840009;6489.215465746957;6502.869942601216;6522.836929076621;4377.518472967908;4395.934060989024;4397.670174736843;4413.823447062082;4422.248217802917;6021.638701677914;6254.593451425825;6308.741599420281;6324.747010119544;6328.303886572381;6129.540284478771;6151.907721384272;6188.8762224754355;6198.907016394848;6217.160683307877;6091.908621370594;6151.6001459904965;6152.846178845564;6161.137440758387;6164.260288765377;5743.569232307677;5813.505852002627;5918.7508746675985;6050.42520960508;6081.391860813883;6144.969275153596;6157.1072194532435;6158.137860699416;6177.598456100519;6189.5048396129105;5908.261467316585;6005.339412664516;6012.819615411545;6033.78881739137;6034 04:10:05 INFO - PROCESS | 419 | |5;yui.html;781.3629002117849;821.1172989036787;823.9217274358933;890.9109089091089;929.5584597316275;16382.26279817408;16994.745078823827;17494.475165745047;17557.736633950484;17640.470785876427;16167.919160404212;16179.757303640456;16325;16332.428365007227;16343.182840857939;869.6130222051174;890.5191196753777;892.6474042753109;893.5978809535702;893.8703887936246;825.5376988886213;859.7205908079868;860.6815478273048;864.416518849777;865.0527672198932;914.309696179387;922.7923717163618;925.0610630210342;926.3932124458457;928.4568527411438;918.4397517514311;921.8110287391069;922.4649703172178;923.9214666753334;923.930705197113;667.5260564998856;672.3444641474572;678.7929681447157;681.6319187638669;682.0178942323089;16537.077753347894;16690.248938797784;16771.2452939618;16776.58058548534;16796.580085497837;14170.645733856736;14566.781498277534;14589.270536473134;15016.699666006727;16350.10074445905;14481.42074317026;14563.49027784033;14660.56018319452;14794.852051479455;15124.319405626664;4773.570378665902;4783.952160478386;4790.4251489821445;4823.951760482385;4837.467878533358;87547;89298;90436;90759.54620226857;91921;12378.071644626689;12438.129330946747;12518.937405313098;12529.310887901252;12700.11099223064;22578.20976265823;22588.54822903533;22592;22618.095276188767;22701.65947510789;8857.070007649232;8910.376273660911;8931.19619234259;9041.641900632814;9380.24958003358;4813.916868704583;4902.240152776325;5158.535731784157;5253.763580638881;5335.039692855245;3886.417037444406;4056.7971601419813;4062.979685101556;4080.673546116363;4087.4073259377224;710.8080818179166;712.1774350625036;722.3390597603134;722.9240929702411;732.0629594119536;697.9406750426169;743.275306576084;803.277050654404;819.7171975668385;827.9420440569223;10033.548490317953;10641.680749577525;10865.728356791144;10883.30507168182;11301.773964520664;690.3683129936153;742.4876834983952;780.1691198873182;789.4513313247238;842.4692443760392;4790.808367665324;5083.796648134107;5204.843854684365;5226.372835259793;5231.346081739783;97424;128994;130372;136961;137145;112266;112651.87348126413;113152;114341;115547;99714;99949;100987.49506252422;102246;103317;9597.838118125548;9739.979887947124;9744.420821005277;9813.702433203192;9832.31173817826;58321.4167858316;58455.415445845;59562;60357;61180.69409652923;83553;86058;86642;86660;88638;12908.677283067998;13141.737165256833;13289.534866279633;13316.866831331563;13433.261170635318;14758.926205368904;14900.329485172977;14917;14958.102513849204;15027.774583381477;14055.648608784863;14190.574282771533;14341.211233382264;14734.189619571027;15053.397864085315;14152.22162781057;14368.856311436752;14407.711845762817;14421.495247666282;14444.494442694455;13820;14756.704865902837;15252.389904403699;15383.153926534149;15903.443379481663;10795.6221532246;10952.890471095187;11431.371274579978;11560.190786644855;11570;11676.124290678063;12046.819297710717;12393.318367489876;12418.254904705747;12562.623121306375 04:10:05 INFO - PROCESS | 419 | __end_tp_report 04:10:05 INFO - PROCESS | 419 | __start_cc_report 04:10:05 INFO - PROCESS | 419 | _x_x_mozilla_cycle_collect,336 04:10:05 INFO - PROCESS | 419 | __end_cc_report 04:10:05 INFO - PROCESS | 419 | __startTimestamp1471518605268__endTimestamp 04:10:05 INFO - PROCESS | 419 | 04:10:05 INFO - PROCESS | 419 | ------- Summary: start ------- 04:10:05 INFO - PROCESS | 419 | Number of tests: 6 04:10:05 INFO - PROCESS | 419 | 04:10:05 INFO - PROCESS | 419 | [#0] dojo.html Cycles:165 Average:5732.42 Median:5945.61 stddev:667.75 (11.2%) stddev-sans-first:642.19 04:10:05 INFO - PROCESS | 419 | Values: 3309.9 3351.0 3353.5 3369.2 3381.0 5718.5 5788.0 5790.0 5791.9 5833.7 5719.9 5728.0 5728.3 5751.5 5754.3 5170.4 5200.3 5218.1 5230.5 5243.8 5114.5 5127.4 5177.2 5189.2 5229.3 5241.2 5250.1 5264.0 5320.1 5335.1 5316.5 5330.4 5340.0 5341.9 5360.7 4967.1 5059.2 5210.2 5223.8 5318.3 5689.9 5774.2 5777.2 5797.0 5821.9 6118.2 6166.5 6191.2 6224.6 6262.3 5892.7 6065.3 6209.3 6235.6 6248.6 5735.1 5830.5 5834.9 5839.1 5861.9 6339.3 6377.2 6389.5 6393.4 6396.9 5858.9 5940.7 6048.8 6112.7 6119.0 6060.5 6114.7 6122.7 6124.9 6221.5 6132.1 6151.5 6177.7 6198.8 6199.2 6111.7 6195.8 6211.9 6217.2 6219.3 4534.3 4567.8 4617.6 4633.8 4725.2 4188.2 4188.5 4191.9 4195.4 4206.8 5871.5 5877.1 5881.3 5882.4 5887.1 5940.4 6112.3 6121.9 6142.8 6282.0 5903.7 5943.9 5945.6 5952.1 5990.5 5022.1 5172.5 5181.7 5182.2 5187.9 6211.7 6330.2 6339.7 6464.4 6472.4 6262.3 6262.4 6271.9 6276.7 6279.5 6116.8 6423.9 6482.6 6486.9 6498.5 5953.5 6074.1 6089.7 6132.0 6132.4 6214.5 6216.1 6236.9 6237.3 6247.0 5835.9 6095.7 6102.8 6103.6 6111.1 5918.9 5961.2 6025.6 6059.8 6099.3 5983.1 6007.2 6028.7 6037.9 6040.5 5890.0 6046.4 6146.6 6148.0 6148.1 5839.9 5886.6 5928.2 5985.7 6014.5 04:10:05 INFO - PROCESS | 419 | 04:10:05 INFO - PROCESS | 419 | [#1] ext.html Cycles:180 Average:63781.14 Median:44530.67 stddev:131127.69 (294.5%) stddev-sans-first:131409.77 04:10:05 INFO - PROCESS | 419 | Values: 614.5 649.6 661.3 687.3 725.2 40817.6 45648.3 45885.8 45980.8 46310.8 45775.1 46004.3 46012.8 46182.8 46295.0 9033.2 9174.3 9178.4 9180.1 9212.8 9098.9 9211.8 9269.7 9306.3 9309.8 9287.7 9321.7 9327.1 9333.5 9337.4 9189.2 9254.7 9259.5 9268.7 9280.4 9142.9 9189.8 9208.2 9217.5 9239.4 43906.0 44463.3 44506.3 44579.8 44706.0 4010.2 4147.8 4536.8 4671.0 4748.4 34533.5 34581.7 35093.3 35343.0 35823.8 3884.8 3887.8 3920.1 3925.3 4017.1 326679.0 326783.0 327548.0 329909.0 329938.0 37318.6 64161.7 64343.4 64377.4 64385.4 38699.0 40711.6 40847.8 40960.2 40980.8 16293.6 16427.3 16448.8 16472.0 16529.0 12652.5 13108.9 13122.1 13168.8 13220.7 9138.4 9282.8 9297.0 9322.9 9376.0 3531.8 3532.4 3578.5 3607.7 3610.4 1084.2 1093.9 1135.7 1176.3 1191.9 32870.7 33444.0 33456.3 33496.0 33682.2 1146.2 1169.3 1170.3 1184.5 1200.4 17650.2 17759.3 17829.7 17862.9 17987.9 612777.0 619176.0 621272.0 621281.0 623241.0 62687.0 62868.4 63507.0 63541.7 63913.0 1464.9 1465.7 1473.2 1481.6 1510.8 32931.7 32974.5 33293.0 33349.0 34233.5 56673.4 57079.7 57082.7 57158.4 57195.4 481708.0 484665.0 485049.0 485544.0 485988.0 30475.0 30968.0 31156.7 31285.1 31393.0 51077.5 51607.5 52060.0 52154.2 53334.7 44555.0 44945.3 45393.0 46130.3 46491.8 44192.3 44841.8 45142.8 46359.8 46774.5 40414.6 43842.3 44437.0 45175.3 46480.3 39704.4 39882.4 40227.4 40586.6 41174.8 28700.3 29016.9 29244.0 29531.0 29938.7 04:10:05 INFO - PROCESS | 419 | 04:10:05 INFO - PROCESS | 419 | [#2] jquery.html Cycles:180 Average:28155.52 Median:21096.37 stddev:76557.58 (362.9%) stddev-sans-first:76744.00 04:10:05 INFO - PROCESS | 419 | Values: 407.8 413.1 422.9 429.7 438.1 19281.6 20230.4 21013.9 21060.4 21132.4 16330.5 19270.7 19585.8 19822.7 20566.5 5237.2 5432.9 5443.8 5458.4 5463.9 4133.4 5409.7 5417.2 5428.3 6613.0 6650.7 6670.9 6678.4 6680.5 6689.1 6575.7 6627.9 6649.9 6698.8 6700.4 5863.3 5878.9 5908.1 5909.5 5931.6 13765.9 14020.9 22086.2 23001.3 23852.8 2649.6 2711.9 3119.3 3146.6 3156.4 10006.8 10102.1 10291.7 12882.3 14762.8 1919.8 1984.6 2017.8 2050.0 2072.2 79872.0 81131.6 81971.6 83992.0 84171.0 10532.5 10693.4 10812.7 11003.7 11320.9 15256.8 15388.3 15396.2 15411.6 15412.4 7942.5 8263.5 8269.0 8347.5 8398.7 8049.0 8077.5 8086.6 8201.3 8228.5 4570.5 4616.8 4659.3 4680.2 4716.5 1898.3 1954.2 1956.1 1996.6 2015.1 986.3 1000.6 1003.8 1006.2 1028.9 19517.6 19735.3 19847.8 20025.0 20510.3 1018.3 1028.5 1079.6 1088.7 1132.0 10549.8 11298.2 11369.7 11370.7 11407.8 386408.0 387305.0 387811.0 557140.0 561471.0 62009.0 63299.7 87814.6 91161.0 102901.5 1062.2 1062.8 1093.8 1094.5 1107.4 18118.3 18480.2 18628.3 18725.3 18798.7 43178.6 43436.8 43482.6 43957.0 44559.6 60758.7 61743.7 62201.7 63126.4 63877.4 8545.1 8600.1 8615.8 8674.9 8739.6 12991.1 13089.3 13202.2 13972.5 14319.1 11815.2 11993.7 12134.2 12214.7 12262.3 11746.9 12051.4 12205.9 12221.6 12321.6 12325.9 12479.3 12569.8 12634.3 12726.1 8320.5 8535.8 8539.4 8800.5 8884.3 11951.1 12115.5 12202.5 12237.6 12681.9 04:10:05 INFO - PROCESS | 419 | 04:10:05 INFO - PROCESS | 419 | [#3] mootools.html Cycles:180 Average:6316.24 Median:4664.04 stddev:3590.74 (77.0%) stddev-sans-first:3582.59 04:10:05 INFO - PROCESS | 419 | Values: 1502.4 1543.8 1691.9 1823.9 1838.6 8303.0 8823.2 9133.3 9355.2 9385.3 9215.1 9442.2 9491.4 9499.2 9500.0 2454.6 2468.0 2486.3 2487.7 2497.1 2413.7 2511.3 2512.5 2514.9 2520.9 2484.9 2494.7 2517.7 2519.8 2522.3 2412.7 2430.2 2439.7 2440.5 2442.1 2387.1 2393.8 2395.8 2425.9 2434.3 9484.1 9640.1 9676.1 9689.6 9693.9 5627.8 5751.4 5765.9 5776.6 5784.9 3538.3 3562.4 3589.9 3638.7 3699.5 1095.6 1100.1 1109.1 1188.7 1192.2 13171.1 13290.1 13291.5 13310.7 13326.9 4851.1 4896.3 4952.4 5005.9 5105.3 11251.8 11291.0 11324.8 11377.3 11384.9 5765.7 5779.5 5780.9 5805.3 5821.6 4708.3 5217.8 5296.9 5323.9 5324.2 4258.1 4327.2 4375.8 4380.4 4423.3 1268.5 1269.2 1270.5 1272.8 1285.3 1020.3 1063.1 1076.2 1088.4 1097.3 6226.7 6263.7 6446.7 6563.3 6766.4 1049.6 1097.9 1098.1 1115.5 1167.7 4624.3 4703.8 4768.5 4777.9 4977.6 11790.6 11822.0 11954.3 11999.9 12106.8 11768.4 11804.9 11821.6 11827.1 11900.9 8273.8 8522.3 8580.1 8722.2 8806.8 6786.4 6873.1 6900.7 6942.7 6968.3 10814.7 11029.3 11187.0 11287.7 11434.1 11209.0 11214.2 11410.6 11464.1 11551.7 8394.3 8424.7 8448.7 8451.5 8462.4 9149.8 9162.5 9191.0 9224.8 9249.0 8013.1 8054.2 8114.0 8119.9 8422.8 8280.1 8457.2 8489.2 8491.5 8527.2 7717.5 7737.2 7742.3 7769.9 7777.9 5583.4 5752.9 5863.1 5958.9 5999.2 5641.7 5642.0 5730.7 5747.6 5813.6 04:10:05 INFO - PROCESS | 419 | 04:10:05 INFO - PROCESS | 419 | [#4] prototype.html Cycles:180 Average:5087.84 Median:5845.85 stddev:1528.71 (26.2%) stddev-sans-first:1490.84 04:10:05 INFO - PROCESS | 419 | Values: 337.4 337.4 343.9 346.5 347.5 5762.5 5815.7 5836.7 5849.7 5861.4 5652.4 5659.2 5728.2 5741.7 5780.5 4286.8 4328.0 4424.8 4454.9 4459.6 4404.8 4436.2 4437.8 4449.0 4463.8 4405.3 4421.8 4426.5 4431.3 4440.2 4293.9 4392.5 4415.5 4424.3 4443.7 3903.2 3912.6 3912.9 3914.9 3927.3 5560.2 5574.6 5598.2 5611.2 5632.9 4837.3 5007.8 5058.8 5066.1 5102.5 5952.9 5996.6 6004.2 6009.2 6037.4 4223.9 4227.3 4239.7 4253.5 4253.6 6091.0 6224.3 6277.5 6290.9 6298.5 4306.7 4325.9 4334.2 4336.3 4341.0 4360.3 4371.9 4378.6 4381.3 4391.3 4915.7 5037.3 5040.6 5047.8 5068.3 6012.7 6051.2 6063.8 6069.5 6070.7 1459.4 1482.1 1514.3 1529.3 1530.5 923.8 960.5 967.7 986.6 1011.0 5783.8 5799.6 5834.5 5842.0 5856.9 6204.5 6205.2 6210.3 6211.4 6233.9 5629.1 5851.9 5889.0 5909.2 5949.9 3283.8 3322.0 3332.8 3342.8 3344.2 6265.0 6417.7 6451.3 6504.7 6529.2 6264.0 6294.0 6300.4 6331.5 6351.2 6239.3 6445.0 6453.6 6456.8 6506.0 6208.6 6254.7 6288.2 6293.6 6309.2 6213.4 6223.0 6231.8 6234.7 6254.6 6320.7 6422.9 6489.2 6502.9 6522.8 4377.5 4395.9 4397.7 4413.8 4422.2 6021.6 6254.6 6308.7 6324.7 6328.3 6129.5 6151.9 6188.9 6198.9 6217.2 6091.9 6151.6 6152.8 6161.1 6164.3 5743.6 5813.5 5918.8 6050.4 6081.4 6145.0 6157.1 6158.1 6177.6 6189.5 5908.3 6005.3 6012.8 6033.8 6034.0 04:10:05 INFO - PROCESS | 419 | 04:10:05 INFO - PROCESS | 419 | [#5] yui.html Cycles:180 Average:23424.56 Median:4084.04 stddev:34373.75 (841.7%) stddev-sans-first:34428.13 04:10:05 INFO - PROCESS | 419 | Values: 781.4 821.1 823.9 890.9 929.6 16382.3 16994.7 17494.5 17557.7 17640.5 16167.9 16179.8 16325.0 16332.4 16343.2 869.6 890.5 892.6 893.6 893.9 825.5 859.7 860.7 864.4 865.1 914.3 922.8 925.1 926.4 928.5 918.4 921.8 922.5 923.9 923.9 667.5 672.3 678.8 681.6 682.0 16537.1 16690.2 16771.2 16776.6 16796.6 14170.6 14566.8 14589.3 15016.7 16350.1 14481.4 14563.5 14660.6 14794.9 15124.3 4773.6 4784.0 4790.4 4824.0 4837.5 87547.0 89298.0 90436.0 90759.5 91921.0 12378.1 12438.1 12518.9 12529.3 12700.1 22578.2 22588.5 22592.0 22618.1 22701.7 8857.1 8910.4 8931.2 9041.6 9380.2 4813.9 4902.2 5158.5 5253.8 5335.0 3886.4 4056.8 4063.0 4080.7 4087.4 710.8 712.2 722.3 722.9 732.1 697.9 743.3 803.3 819.7 827.9 10033.5 10641.7 10865.7 10883.3 11301.8 690.4 742.5 780.2 789.5 842.5 4790.8 5083.8 5204.8 5226.4 5231.3 97424.0 128994.0 130372.0 136961.0 137145.0 112266.0 112651.9 113152.0 114341.0 115547.0 99714.0 99949.0 100987.5 102246.0 103317.0 9597.8 9740.0 9744.4 9813.7 9832.3 58321.4 58455.4 59562.0 60357.0 61180.7 83553.0 86058.0 86642.0 86660.0 88638.0 12908.7 13141.7 13289.5 13316.9 13433.3 14758.9 14900.3 14917.0 14958.1 15027.8 14055.6 14190.6 14341.2 14734.2 15053.4 14152.2 14368.9 14407.7 14421.5 14444.5 13820.0 14756.7 15252.4 15383.2 15903.4 10795.6 10952.9 11431.4 11560.2 11570.0 11676.1 12046.8 12393.3 12418.3 12562.6 04:10:05 INFO - PROCESS | 419 | -------- Summary: end -------- 04:10:05 INFO - PROCESS | 419 | 04:10:05 INFO - TEST-INFO | 419: exit 0 04:10:05 INFO - TEST-OK | dromaeo_css | took 1110774ms 04:10:05 INFO - TEST-START | kraken 04:10:05 INFO - operating with platform_type : linux_ 04:10:05 INFO - Initialising browser for kraken test... 04:10:05 INFO - TEST-INFO | started process 691 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpV7s_wC/profile http://localhost:53852/getInfo.html) 04:10:10 INFO - PROCESS | 691 | __metrics Screen width/height:1600/1200 04:10:10 INFO - PROCESS | 691 | colorDepth:24 04:10:10 INFO - PROCESS | 691 | Browser inner width/height: 1024/697 04:10:10 INFO - PROCESS | 691 | __metrics 04:10:10 ERROR - PROCESS | 691 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 04:10:11 INFO - TEST-INFO | 691: exit 0 04:10:11 INFO - Browser initialized. 04:10:11 INFO - Running cycle 1/1 for kraken test... 04:10:11 INFO - TEST-INFO | started process 827 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpV7s_wC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:10:23 INFO - PROCESS | 827 | RSS: Main: 152264704 04:10:23 INFO - PROCESS | 827 | 04:10:25 INFO - PROCESS | 827 | Cycle 1(1): loaded http://localhost:53852/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53852/tests/kraken/driver.html?testName=audio-beat-detection) 04:10:26 INFO - PROCESS | 827 | RSS: Main: 157798400 04:10:26 INFO - PROCESS | 827 | 04:10:29 INFO - PROCESS | 827 | Cycle 1(1): loaded http://localhost:53852/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53852/tests/kraken/driver.html?testName=audio-dft) 04:10:29 INFO - PROCESS | 827 | RSS: Main: 156217344 04:10:29 INFO - PROCESS | 827 | 04:10:32 INFO - PROCESS | 827 | Cycle 1(1): loaded http://localhost:53852/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53852/tests/kraken/driver.html?testName=audio-fft) 04:10:33 INFO - PROCESS | 827 | RSS: Main: 157020160 04:10:33 INFO - PROCESS | 827 | 04:10:35 INFO - PROCESS | 827 | Cycle 1(1): loaded http://localhost:53852/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53852/tests/kraken/driver.html?testName=audio-oscillator) 04:10:36 INFO - PROCESS | 827 | RSS: Main: 156229632 04:10:36 INFO - PROCESS | 827 | 04:10:38 INFO - PROCESS | 827 | Cycle 1(1): loaded http://localhost:53852/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53852/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:10:38 INFO - PROCESS | 827 | RSS: Main: 156688384 04:10:38 INFO - PROCESS | 827 | 04:10:42 INFO - PROCESS | 827 | Cycle 1(1): loaded http://localhost:53852/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53852/tests/kraken/driver.html?testName=imaging-darkroom) 04:10:42 INFO - PROCESS | 827 | RSS: Main: 155922432 04:10:42 INFO - PROCESS | 827 | 04:10:46 INFO - PROCESS | 827 | Cycle 1(1): loaded http://localhost:53852/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53852/tests/kraken/driver.html?testName=imaging-desaturate) 04:10:46 INFO - PROCESS | 827 | RSS: Main: 155058176 04:10:46 INFO - PROCESS | 827 | 04:10:49 INFO - PROCESS | 827 | Cycle 1(1): loaded http://localhost:53852/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53852/tests/kraken/driver.html?testName=json-parse-financial) 04:10:50 INFO - PROCESS | 827 | RSS: Main: 156336128 04:10:50 INFO - PROCESS | 827 | 04:10:51 INFO - PROCESS | 827 | Cycle 1(1): loaded http://localhost:53852/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53852/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:10:52 INFO - PROCESS | 827 | RSS: Main: 156282880 04:10:52 INFO - PROCESS | 827 | 04:10:54 INFO - PROCESS | 827 | Cycle 1(1): loaded http://localhost:53852/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53852/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:10:54 INFO - PROCESS | 827 | RSS: Main: 156864512 04:10:54 INFO - PROCESS | 827 | 04:10:56 INFO - PROCESS | 827 | Cycle 1(1): loaded http://localhost:53852/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53852/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:10:57 INFO - PROCESS | 827 | RSS: Main: 156704768 04:10:57 INFO - PROCESS | 827 | 04:10:59 INFO - PROCESS | 827 | Cycle 1(1): loaded http://localhost:53852/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53852/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:11:00 INFO - PROCESS | 827 | RSS: Main: 157609984 04:11:00 INFO - PROCESS | 827 | 04:11:03 INFO - PROCESS | 827 | Cycle 1(1): loaded http://localhost:53852/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53852/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:11:03 INFO - PROCESS | 827 | RSS: Main: 157249536 04:11:03 INFO - PROCESS | 827 | 04:11:05 INFO - PROCESS | 827 | Cycle 1(1): loaded http://localhost:53852/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53852/tests/kraken/driver.html?testName=ai-astar) 04:11:05 INFO - PROCESS | 827 | RSS: Main: 158076928 04:11:05 INFO - PROCESS | 827 | 04:11:05 INFO - PROCESS | 827 | __start_tp_report 04:11:05 INFO - PROCESS | 827 | _x_x_mozilla_page_load 04:11:05 INFO - PROCESS | 827 | _x_x_mozilla_page_load_details 04:11:05 INFO - PROCESS | 827 | |i|pagename|runs| 04:11:05 INFO - PROCESS | 827 | |0;ai-astar;102;111;106;110;111;113;112;110;114;109 04:11:05 INFO - PROCESS | 827 | |1;audio-beat-detection;147;115;143;184;116;142;144;118;171;118 04:11:05 INFO - PROCESS | 827 | |2;audio-dft;161;161;162;161;162;161;162;162;162;164 04:11:05 INFO - PROCESS | 827 | |3;audio-fft;74;76;76;187;77;75;75;77;184;76 04:11:05 INFO - PROCESS | 827 | |4;audio-oscillator;84;85;154;83;83;84;143;84;84;146 04:11:05 INFO - PROCESS | 827 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;118;118;118 04:11:05 INFO - PROCESS | 827 | |6;imaging-darkroom;149;148;152;148;148;148;148;147;147;147 04:11:05 INFO - PROCESS | 827 | |7;imaging-desaturate;95;95;97;95;96;95;94;95;95;95 04:11:05 INFO - PROCESS | 827 | |8;json-parse-financial;53;54;51;53;54;52;55;54;53;53 04:11:05 INFO - PROCESS | 827 | |9;json-stringify-tinderbox;61;59;59;60;59;59;59;60;59;59 04:11:05 INFO - PROCESS | 827 | |10;stanford-crypto-aes;73;82;72;73;75;73;72;77;79;78 04:11:05 INFO - PROCESS | 827 | |11;stanford-crypto-ccm;122;127;123;128;118;119;119;128;155;119 04:11:05 INFO - PROCESS | 827 | |12;stanford-crypto-pbkdf2;161;171;157;156;157;160;172;164;160;157 04:11:05 INFO - PROCESS | 827 | |13;stanford-crypto-sha256-iterative;64;62;67;63;64;62;62;63;61;65 04:11:05 INFO - PROCESS | 827 | __end_tp_report 04:11:05 INFO - PROCESS | 827 | __start_cc_report 04:11:05 INFO - PROCESS | 827 | _x_x_mozilla_cycle_collect,874 04:11:05 INFO - PROCESS | 827 | __end_cc_report 04:11:05 INFO - PROCESS | 827 | __startTimestamp1471518665815__endTimestamp 04:11:05 INFO - PROCESS | 827 | 04:11:05 INFO - PROCESS | 827 | ------- Summary: start ------- 04:11:05 INFO - PROCESS | 827 | Number of tests: 14 04:11:05 INFO - PROCESS | 827 | 04:11:05 INFO - PROCESS | 827 | [#0] ai-astar Cycles:10 Average:109.80 Median:111.00 stddev:3.52 (3.2%) stddev-sans-first:2.35 04:11:05 INFO - PROCESS | 827 | Values: 102.0 111.0 106.0 110.0 111.0 113.0 112.0 110.0 114.0 109.0 04:11:05 INFO - PROCESS | 827 | 04:11:05 INFO - PROCESS | 827 | [#1] audio-beat-detection Cycles:10 Average:139.80 Median:143.50 stddev:23.91 (16.7%) stddev-sans-first:25.21 04:11:05 INFO - PROCESS | 827 | Values: 147.0 115.0 143.0 184.0 116.0 142.0 144.0 118.0 171.0 118.0 04:11:05 INFO - PROCESS | 827 | 04:11:05 INFO - PROCESS | 827 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:0.92 (0.6%) stddev-sans-first:0.93 04:11:05 INFO - PROCESS | 827 | Values: 161.0 161.0 162.0 161.0 162.0 161.0 162.0 162.0 162.0 164.0 04:11:05 INFO - PROCESS | 827 | 04:11:05 INFO - PROCESS | 827 | [#3] audio-fft Cycles:10 Average:97.70 Median:76.00 stddev:46.29 (60.9%) stddev-sans-first:48.30 04:11:05 INFO - PROCESS | 827 | Values: 74.0 76.0 76.0 187.0 77.0 75.0 75.0 77.0 184.0 76.0 04:11:05 INFO - PROCESS | 827 | 04:11:05 INFO - PROCESS | 827 | [#4] audio-oscillator Cycles:10 Average:103.00 Median:84.00 stddev:30.94 (36.8%) stddev-sans-first:32.05 04:11:05 INFO - PROCESS | 827 | Values: 84.0 85.0 154.0 83.0 83.0 84.0 143.0 84.0 84.0 146.0 04:11:05 INFO - PROCESS | 827 | 04:11:05 INFO - PROCESS | 827 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 04:11:05 INFO - PROCESS | 827 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 118.0 118.0 04:11:05 INFO - PROCESS | 827 | 04:11:05 INFO - PROCESS | 827 | [#6] imaging-darkroom Cycles:10 Average:148.20 Median:148.00 stddev:1.48 (1.0%) stddev-sans-first:1.54 04:11:05 INFO - PROCESS | 827 | Values: 149.0 148.0 152.0 148.0 148.0 148.0 148.0 147.0 147.0 147.0 04:11:05 INFO - PROCESS | 827 | 04:11:05 INFO - PROCESS | 827 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.79 (0.8%) stddev-sans-first:0.83 04:11:05 INFO - PROCESS | 827 | Values: 95.0 95.0 97.0 95.0 96.0 95.0 94.0 95.0 95.0 95.0 04:11:05 INFO - PROCESS | 827 | 04:11:05 INFO - PROCESS | 827 | [#8] json-parse-financial Cycles:10 Average:53.20 Median:53.50 stddev:1.14 (2.1%) stddev-sans-first:1.20 04:11:05 INFO - PROCESS | 827 | Values: 53.0 54.0 51.0 53.0 54.0 52.0 55.0 54.0 53.0 53.0 04:11:05 INFO - PROCESS | 827 | 04:11:05 INFO - PROCESS | 827 | [#9] json-stringify-tinderbox Cycles:10 Average:59.40 Median:59.00 stddev:0.70 (1.2%) stddev-sans-first:0.44 04:11:05 INFO - PROCESS | 827 | Values: 61.0 59.0 59.0 60.0 59.0 59.0 59.0 60.0 59.0 59.0 04:11:05 INFO - PROCESS | 827 | 04:11:05 INFO - PROCESS | 827 | [#10] stanford-crypto-aes Cycles:10 Average:75.40 Median:76.00 stddev:3.44 (4.5%) stddev-sans-first:3.54 04:11:05 INFO - PROCESS | 827 | Values: 73.0 82.0 72.0 73.0 75.0 73.0 72.0 77.0 79.0 78.0 04:11:05 INFO - PROCESS | 827 | 04:11:05 INFO - PROCESS | 827 | [#11] stanford-crypto-ccm Cycles:10 Average:125.80 Median:125.00 stddev:10.98 (8.8%) stddev-sans-first:11.56 04:11:05 INFO - PROCESS | 827 | Values: 122.0 127.0 123.0 128.0 118.0 119.0 119.0 128.0 155.0 119.0 04:11:05 INFO - PROCESS | 827 | 04:11:05 INFO - PROCESS | 827 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.50 Median:160.50 stddev:5.80 (3.6%) stddev-sans-first:6.15 04:11:05 INFO - PROCESS | 827 | Values: 161.0 171.0 157.0 156.0 157.0 160.0 172.0 164.0 160.0 157.0 04:11:05 INFO - PROCESS | 827 | 04:11:05 INFO - PROCESS | 827 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.30 Median:63.50 stddev:1.77 (2.8%) stddev-sans-first:1.86 04:11:05 INFO - PROCESS | 827 | Values: 64.0 62.0 67.0 63.0 64.0 62.0 62.0 63.0 61.0 65.0 04:11:05 INFO - PROCESS | 827 | -------- Summary: end -------- 04:11:05 INFO - PROCESS | 827 | 04:11:06 INFO - TEST-INFO | 827: exit 0 04:11:06 INFO - TEST-OK | kraken | took 60801ms 04:11:06 INFO - SUITE-END | took 1171s 04:11:06 INFO - Completed test suite (00:19:31) 04:11:06 INFO - javascript benchmark 04:11:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7710.334134647924, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3309.8841540546077, 3351.028201821472, 3353.5305057291985, 3369.225078232005, 3380.9830950845258, 5718.542516598673, 5788.0, 5789.971050144749, 5791.855203619912, 5833.679147646878, 5719.857003574903, 5728.0, 5728.3126024876965, 5751.482366587006, 5754.338251101125, 5170.353705786777, 5200.349956255468, 5218.0607490651855, 5230.450802665722, 5243.764030618631, 5114.539691427771, 5127.384713834345, 5177.249298851683, 5189.169732842746, 5229.294045303893, 5241.161414173714, 5250.133727934886, 5264.0, 5320.14877619581, 5335.146376579748, 5316.521513063804, 5330.387005494379, 5340.0, 5341.919871201935, 5360.705161216131, 4967.130752118401, 5059.215821547666, 5210.244514545408, 5223.764930578095, 5318.308619879391, 5689.9146512802345, 5774.220480235199, 5777.162311464814, 5797.043487824504, 5821.941780582225, 6118.20463339763, 6166.475849552793, 6191.195144631214, 6224.595401298946, 6262.2798378186635, 5892.705364731746, 6065.332813390523, 6209.348018458088, 6235.563510554263, 6248.625082495065, 5735.139729040636, 5830.533557315404, 5834.949709052411, 5839.124131380327, 5861.912071318934, 6339.288392134098, 6377.23473183221, 6389.520785941073, 6393.424591786761, 6396.872062558723, 5858.882822343615, 5940.702964851826, 6048.818535443944, 6112.663803490851, 6119.0, 6060.545459090497, 6114.723190878713, 6122.6727265478185, 6124.908126378108, 6221.471174950089, 6132.141500189977, 6151.477124444473, 6177.69111544421, 6198.81403557894, 6199.194104766351, 6111.724972376165, 6195.783147589813, 6211.9068213976825, 6217.160683307786, 6219.346968568326, 4534.274516077412, 4567.81728730847, 4617.561331673553, 4633.7683115844075, 4725.243960966229, 4188.246115699142, 4188.455500784939, 4191.937120943188, 4195.391668208093, 4206.789660516962, 5871.530277577784, 5877.089051197071, 5881.264841894763, 5882.3529411764675, 5887.087501437284, 5940.376260492672, 6112.321110680095, 6121.940772762995, 6142.8057410146475, 6282.0, 5903.704814759245, 5943.881122377528, 5945.613535120204, 5952.136940143741, 5990.460858522754, 5022.070916880389, 5172.508611681884, 5181.740912954338, 5182.222666600041, 5187.896242075213, 6211.65835879031, 6330.208723909512, 6339.714712837934, 6464.41820236181, 6472.385123413268, 6262.34245404226, 6262.373762623702, 6271.874562508633, 6276.6547839869245, 6279.497640188682, 6116.8227554565365, 6423.871522569616, 6482.57863238888, 6486.870262594816, 6498.512611554058, 5953.523718102455, 6074.119252708421, 6089.665068421279, 6132.049532322497, 6132.448079672851, 6214.5028397727165, 6216.098665693358, 6236.937630623817, 6237.345078766845, 6246.968765156327, 5835.883282334415, 6095.664738439251, 6102.786402476069, 6103.572749907464, 6111.052786818051, 5918.852028699317, 5961.165436838759, 6025.638461692312, 6059.787907423219, 6099.298580663103, 5983.132445795248, 6007.219061521974, 6028.668423236764, 6037.879242415039, 6040.546958978006, 5890.0, 6046.4255895691595, 6146.6004709693725, 6148.016317389196, 6148.1085242640465, 5839.912401314069, 5886.6173698709445, 5928.229330187048, 5985.730642121202, 6014.548908831767], "value": 5686.576176814105, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [614.5329549542347, 649.5777744466097, 661.348571656918, 687.3058211206683, 725.176924191043, 40817.59182408175, 45648.3152752709, 45885.7705711471, 45980.77009614956, 46310.76844615777, 45775.08449831001, 46004.309935351, 46012.769936150275, 46182.76908615461, 46295.0, 9033.187013168814, 9174.311926605531, 9178.449293042406, 9180.081991800833, 9212.815743685122, 9098.909010909905, 9211.815763684723, 9269.721908342726, 9306.255499560019, 9309.767255818591, 9287.674931377403, 9321.673741419052, 9327.113924177227, 9333.53332333384, 9337.393069450498, 9189.218916392114, 9254.676086336945, 9259.537023148849, 9268.721938341827, 9280.396774209723, 9142.908570914273, 9189.81620367589, 9208.217301529377, 9217.493037882914, 9239.353245272767, 43906.0, 44463.33305000428, 44506.33240501395, 44579.77710111461, 44706.0, 4010.218007488541, 4147.771872547009, 4536.7504787236685, 4671.04243630055, 4748.38271024768, 34533.4819977698, 34581.65418345809, 35093.29813403718, 35343.0, 35823.82088089569, 3884.76691398517, 3887.786171760552, 3920.0787814863484, 3925.3326934421216, 4017.0760725033406, 326679.0, 326783.0, 327548.0, 329909.0, 329938.0, 37318.62681373206, 64161.67919160468, 64343.356566434675, 64377.356226438074, 64385.35614643794, 38699.0, 40711.59288407078, 40847.795761021596, 40960.1807963839, 40980.79509602433, 16293.59266018359, 16427.260773265232, 16448.75326870098, 16472.0, 16529.0, 12652.493900243888, 13108.868911310765, 13122.081454298299, 13168.802467962989, 13220.669483262804, 9138.406003609743, 9282.767930801783, 9296.95351523238, 9322.86015709765, 9376.0, 3531.805750683686, 3532.3994920863515, 3578.534790477221, 3607.6753092221825, 3610.3862343401684, 1084.2247792828166, 1093.9398333091756, 1135.6536256441864, 1176.264834478451, 1191.93444360561, 32870.67129328724, 33444.0, 33456.330873382394, 33496.0, 33682.15794605154, 1146.1804809561204, 1169.3042639629407, 1170.2861254634665, 1184.4551506307196, 1200.4417945655312, 17650.205740741698, 17759.289628414717, 17829.7325540117, 17862.910685446488, 17987.910060449613, 612777.0, 619176.0, 621272.0, 621281.0, 623241.0, 62687.0, 62868.371316286255, 63507.0, 63541.68229158917, 63913.04130438047, 1464.8828093752688, 1465.6775509387917, 1473.1897456398938, 1481.585156156278, 1510.8366557750471, 32931.67068329286, 32974.5053824188, 33293.0, 33348.9882588059, 34233.486497702055, 56673.43326566681, 57079.71460142673, 57082.7145864268, 57158.42841571531, 57195.42804572068, 481708.0, 484665.0, 485049.0, 485544.0, 485988.0, 30475.0, 30968.0, 31156.688433116284, 31285.06144815659, 31393.0, 51077.489225107274, 51607.48392516177, 52060.0, 52154.21768673397, 53334.73332633312, 44555.0, 44945.32582011207, 45393.0, 46130.308045378675, 46491.76754116208, 44192.33711494395, 44841.77579112084, 45142.77428612836, 46359.768201158775, 46774.53225467838, 40414.59585404109, 43842.342364863915, 44437.0, 45175.32237016382, 46480.302795458774, 39704.40443393409, 39882.40176397299, 40227.3965890506, 40586.594134059465, 41174.79412602918, 28700.282492937007, 29016.854915725286, 29244.0, 29531.0, 29938.70061299359], "value": 20229.010387016577, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [407.82463540677514, 413.10562631901934, 422.8541153302111, 429.7035045818385, 438.10626322302505, 19281.614367712657, 20230.39308820736, 21013.894930525326, 21060.36818895432, 21132.366029019115, 16330.51008469745, 19270.71093933592, 19585.804141958575, 19822.70265946012, 20566.48583785406, 5237.162054071349, 5432.945670543283, 5443.8094666686675, 5458.399576046631, 5463.863403414906, 4133.359329303963, 5409.7295135243085, 5417.160340147264, 5428.294321738188, 6613.041109039186, 6650.733970641193, 6670.866582668344, 6678.365555272241, 6680.465562754968, 6689.130413046297, 6575.671216439183, 6627.933720662804, 6649.93350066498, 6698.799036028927, 6700.3969642732145, 5863.325717542494, 5878.882422351529, 5908.084246941731, 5909.527237820964, 5931.6441013539325, 13765.931170344084, 14020.92989535056, 22086.233101351852, 23001.309960701205, 23852.761472385402, 2649.576067829157, 2711.91864244073, 3119.313750974782, 3146.57521234635, 3156.384505021522, 10006.799864002753, 10102.09081182697, 10291.691249262534, 12882.291473968928, 14762.778558321634, 1919.7696276446916, 1984.5688832325764, 2017.778044415113, 2050.015992323693, 2072.2332736887447, 79872.0, 81131.62287233495, 81971.59014204891, 83991.99999999939, 84171.0, 10532.473376331152, 10693.41186234749, 10812.67561973142, 11003.724906877393, 11320.886791132149, 15256.771148432783, 15388.30752616135, 15396.230188490754, 15411.614709632124, 15412.383504659912, 7942.483738557091, 8263.545504997162, 8269.0, 8347.54088525137, 8398.748037558884, 8048.959755201186, 8077.515349079074, 8086.636101375452, 8201.343892488587, 8228.465149765247, 4570.520095390003, 4616.792244349012, 4659.347691323217, 4680.204365257914, 4716.504766999485, 1898.2976298769543, 1954.189011560215, 1956.0708663384778, 1996.5707372914603, 2015.0932080563805, 986.2553771902168, 1000.6097621927454, 1003.8243307421318, 1006.1799633298838, 1028.861103750999, 19517.576701510556, 19735.309264175972, 19847.801521984595, 20025.0, 20510.282140125324, 1018.2821111116644, 1028.4806172882795, 1079.5735684404774, 1088.7169335972703, 1131.971700707489, 10549.789004220027, 11298.152638552141, 11369.658910232707, 11370.715732106599, 11407.771844563062, 386408.0, 387305.0, 387811.0, 557140.0, 561471.0, 62009.0, 63299.6835015822, 87814.56092719495, 91161.0, 102901.48549257356, 1062.150279776176, 1062.8246339354075, 1093.8085834978688, 1094.518411898778, 1107.4186052322434, 18118.27526898909, 18480.16839242264, 18628.348007819663, 18725.344612938483, 18798.718019229447, 43178.56821431871, 43436.78281608572, 43482.56517434785, 43957.0, 44559.55440445684, 60758.69620651868, 61743.6912815433, 62201.68899155475, 63126.36873631205, 63877.36122638714, 8545.145485451405, 8600.053994060523, 8615.784605384915, 8674.869876951725, 8739.563021848755, 12991.090623656253, 13089.345532723517, 13202.207867527979, 13972.510962116277, 14319.069260498034, 11815.232009919328, 11993.700157496132, 12134.211276267015, 12214.694632634255, 12262.325572093621, 11746.882531174579, 12051.397430128634, 12205.87794122083, 12221.572244971383, 12321.568745093879, 12325.876741232472, 12479.31363775001, 12569.811452828399, 12634.305113218861, 12726.109172357847, 8320.459170153921, 8535.786605334917, 8539.40224184326, 8800.515971621366, 8884.333674974532, 11951.103667225167, 12115.515379385079, 12202.450889709808, 12237.571684991339, 12681.93659031699], "value": 9499.969225392764, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1502.376513746795, 1543.7993060902083, 1691.8815682902193, 1823.9056566060358, 1838.6138910828734, 8302.95848520758, 8823.205911467967, 9133.315001374891, 9355.204807591363, 9385.343025988184, 9215.078492150782, 9442.150206481416, 9491.430514169155, 9499.192568631657, 9500.0, 2454.607262837942, 2467.9753202468014, 2486.29140694902, 2487.7139129000216, 2497.063601149569, 2413.710354757423, 2511.3219430753684, 2512.4975004998983, 2514.9497010059786, 2520.9495810083786, 2484.9006039758387, 2494.675692160026, 2517.7230504644476, 2519.8110141739353, 2522.293757747824, 2412.662227288181, 2430.2466235467064, 2439.658447817307, 2440.487497625501, 2442.120836498859, 2387.069043073203, 2393.8324317297797, 2395.808335333169, 2425.9447140493767, 2434.330559096245, 9484.099010593982, 9640.08419200182, 9676.080772326617, 9689.563969621384, 9693.854592181053, 5627.831165065014, 5751.3961034091235, 5765.884682306372, 5776.566757493163, 5784.8843023139725, 3538.292341531678, 3562.447820587813, 3589.94615080774, 3638.727095467824, 3699.5005674233903, 1095.5672509358837, 1100.1100110011005, 1109.1459576126417, 1188.7147084699695, 1192.1893112683372, 13171.143875648053, 13290.136141150795, 13291.468341266338, 13310.667233319147, 13326.933365333209, 4851.102546028996, 4896.2655601660035, 4952.405711314594, 5005.874853128701, 5105.285260063594, 11251.774964500664, 11291.040261577693, 11324.773504529863, 11377.2604780689, 11384.886151138548, 5765.711714414347, 5779.508741756914, 5780.913286300709, 5805.303363596396, 5821.592488525763, 4708.293755936568, 5217.8173763918085, 5296.867578310496, 5323.893522129613, 5324.201369794562, 4258.148370325947, 4327.17783621111, 4375.824967001348, 4380.364847097153, 4423.270160423494, 1268.517963173988, 1269.238456925837, 1270.5426046623209, 1272.783318583633, 1285.3252042677668, 1020.3163880200284, 1063.1335461598771, 1076.1659713721929, 1088.4068182840372, 1097.2922465010024, 6226.688665566703, 6263.718132683949, 6446.7421303148285, 6563.310852360433, 6766.424853887376, 1049.6221360310283, 1097.8682558092921, 1098.0501865885951, 1115.5426275227119, 1167.7430965187646, 4624.28323609841, 4703.7883295251795, 4768.523147685273, 4777.948851252719, 4977.601791856643, 11790.587329443428, 11822.0, 11954.342511161796, 11999.940000299943, 12106.81839772404, 11768.35274059935, 11804.940975295069, 11821.586244481574, 11827.112966527546, 11900.940495297642, 8273.8345233095, 8522.27560657351, 8580.14198580137, 8722.215000649845, 8806.779830504289, 6786.423154031962, 6873.072135261676, 6900.723971041102, 6942.722291108299, 6968.338007889242, 10814.675559733221, 11029.283096598696, 11187.0, 11287.661370158909, 11434.08527317796, 11209.0, 11214.215004949901, 11410.600628977945, 11464.140189485988, 11551.711207219887, 8394.328453723565, 8424.705135320235, 8448.66205351779, 8451.492910425393, 8462.449940753831, 9149.817003660022, 9162.450252984576, 9190.954045229731, 9224.815503690023, 9249.028851970446, 8013.118556958613, 8054.23484768946, 8114.0, 8119.878201826859, 8422.831543368975, 8280.089190189196, 8457.154284571494, 8489.151084891462, 8491.5329656867, 8527.18991695788, 7717.459777815499, 7737.226277372218, 7742.264484873928, 7769.92230077692, 7777.92222077772, 5583.385827559046, 5752.942470575241, 5863.091220860773, 5958.851028724143, 5999.160117583455, 5641.689707066151, 5641.971790141023, 5730.656160630376, 5747.597668163356, 5813.563982701399], "value": 5040.0105689067195, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [337.3910092283428, 337.3977450251302, 343.9380911435942, 346.52179991611587, 347.4544964405884, 5762.510186634136, 5815.709214539277, 5836.7450998035365, 5849.707514624268, 5861.3552509224055, 5652.406497317774, 5659.207710920464, 5728.22668939693, 5741.684207368604, 5780.50865676418, 4286.807093680784, 4327.978360108195, 4424.756638384888, 4454.8886277842985, 4459.643228541725, 4404.757738324391, 4436.2458382074965, 4437.778111094449, 4448.95449569351, 4463.821447142127, 4405.295152775557, 4421.833301682169, 4426.490953540336, 4431.335299705038, 4440.156370289635, 4293.871183864473, 4392.450943632046, 4415.536368681291, 4424.3142312941545, 4443.711158774701, 3903.238868420659, 3912.56961734209, 3912.921741565181, 3914.921701565981, 3927.273454410943, 5560.221568980346, 5574.637648552872, 5598.188262701886, 5611.186377975211, 5632.887342253173, 4837.298591704183, 5007.84976450707, 5058.848234552969, 5066.113430149709, 5102.474275233746, 5952.880942381128, 5996.610220335708, 6004.219451471325, 6009.218801555813, 6037.426444487766, 4223.873283801491, 4227.266820603538, 4239.724417912826, 4253.468316460442, 4253.595908388698, 6091.0, 6224.284207316171, 6277.52918531112, 6290.937090629081, 6298.527610429236, 4306.698531102856, 4325.870223893288, 4334.241507736134, 4336.262835318003, 4340.956590434055, 4360.345948107809, 4371.890702732394, 4378.627816635558, 4381.298992161239, 4391.341298805205, 4915.729634870117, 5037.319961805109, 5040.621953353513, 5047.772850221675, 5068.341115654941, 6012.7294271757, 6051.152838602599, 6063.787767428119, 6069.544784141207, 6070.696465176812, 1459.3797636004656, 1482.0662982321069, 1514.258013573341, 1529.3041666041925, 1530.4566878758103, 923.8244733500613, 960.5293406231036, 967.6806653804368, 986.5954958466995, 1010.9646162384281, 5783.797567085132, 5799.5650326225705, 5834.533237341087, 5842.0, 5856.8535786604825, 6204.503639708812, 6205.162303089025, 6210.254769427697, 6211.409916058057, 6233.875322493524, 5629.127485239795, 5851.941480585225, 5888.9705551472825, 5909.202257695242, 5949.940500595025, 3283.7537184710764, 3321.983390083034, 3332.8333583320737, 3342.8495717692763, 3344.2308269097757, 6265.0, 6417.711202995876, 6451.258105317855, 6504.707288172043, 6529.15121034272, 6263.96868015657, 6293.96853015732, 6300.401461861115, 6331.461825744771, 6351.17434733491, 6239.344868788712, 6444.967775161094, 6453.6121634994415, 6456.806295811133, 6506.0, 6208.627482350893, 6254.718537665907, 6288.182536270256, 6293.590916590407, 6309.179806625109, 6213.440790328892, 6223.0, 6231.813045608639, 6234.657093859882, 6254.6247225166635, 6320.683965801783, 6422.916999840009, 6489.215465746957, 6502.869942601216, 6522.836929076621, 4377.518472967908, 4395.934060989024, 4397.670174736843, 4413.823447062082, 4422.248217802917, 6021.638701677914, 6254.593451425825, 6308.741599420281, 6324.747010119544, 6328.303886572381, 6129.540284478771, 6151.907721384272, 6188.8762224754355, 6198.907016394848, 6217.160683307877, 6091.908621370594, 6151.6001459904965, 6152.846178845564, 6161.137440758387, 6164.260288765377, 5743.569232307677, 5813.505852002627, 5918.7508746675985, 6050.42520960508, 6081.391860813883, 6144.969275153596, 6157.1072194532435, 6158.137860699416, 6177.598456100519, 6189.5048396129105, 5908.261467316585, 6005.339412664516, 6012.819615411545, 6033.78881739137, 6034.0], "value": 4590.101296663331, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [781.3629002117849, 821.1172989036787, 823.9217274358933, 890.9109089091089, 929.5584597316275, 16382.26279817408, 16994.745078823827, 17494.475165745047, 17557.736633950484, 17640.470785876427, 16167.919160404212, 16179.757303640456, 16325.0, 16332.428365007227, 16343.182840857939, 869.6130222051174, 890.5191196753777, 892.6474042753109, 893.5978809535702, 893.8703887936246, 825.5376988886213, 859.7205908079868, 860.6815478273048, 864.416518849777, 865.0527672198932, 914.309696179387, 922.7923717163618, 925.0610630210342, 926.3932124458457, 928.4568527411438, 918.4397517514311, 921.8110287391069, 922.4649703172178, 923.9214666753334, 923.930705197113, 667.5260564998856, 672.3444641474572, 678.7929681447157, 681.6319187638669, 682.0178942323089, 16537.077753347894, 16690.248938797784, 16771.2452939618, 16776.58058548534, 16796.580085497837, 14170.645733856736, 14566.781498277534, 14589.270536473134, 15016.699666006727, 16350.10074445905, 14481.42074317026, 14563.49027784033, 14660.56018319452, 14794.852051479455, 15124.319405626664, 4773.570378665902, 4783.952160478386, 4790.4251489821445, 4823.951760482385, 4837.467878533358, 87547.0, 89298.0, 90436.0, 90759.54620226857, 91921.0, 12378.071644626689, 12438.129330946747, 12518.937405313098, 12529.310887901252, 12700.11099223064, 22578.20976265823, 22588.54822903533, 22592.0, 22618.095276188767, 22701.65947510789, 8857.070007649232, 8910.376273660911, 8931.19619234259, 9041.641900632814, 9380.24958003358, 4813.916868704583, 4902.240152776325, 5158.535731784157, 5253.763580638881, 5335.039692855245, 3886.417037444406, 4056.7971601419813, 4062.979685101556, 4080.673546116363, 4087.4073259377224, 710.8080818179166, 712.1774350625036, 722.3390597603134, 722.9240929702411, 732.0629594119536, 697.9406750426169, 743.275306576084, 803.277050654404, 819.7171975668385, 827.9420440569223, 10033.548490317953, 10641.680749577525, 10865.728356791144, 10883.30507168182, 11301.773964520664, 690.3683129936153, 742.4876834983952, 780.1691198873182, 789.4513313247238, 842.4692443760392, 4790.808367665324, 5083.796648134107, 5204.843854684365, 5226.372835259793, 5231.346081739783, 97424.0, 128994.0, 130372.0, 136961.0, 137145.0, 112266.0, 112651.87348126413, 113152.0, 114341.0, 115547.0, 99714.0, 99949.0, 100987.49506252422, 102246.0, 103317.0, 9597.838118125548, 9739.979887947124, 9744.420821005277, 9813.702433203192, 9832.31173817826, 58321.4167858316, 58455.415445845, 59562.0, 60357.0, 61180.69409652923, 83553.0, 86058.0, 86642.0, 86660.0, 88638.0, 12908.677283067998, 13141.737165256833, 13289.534866279633, 13316.866831331563, 13433.261170635318, 14758.926205368904, 14900.329485172977, 14917.0, 14958.102513849204, 15027.774583381477, 14055.648608784863, 14190.574282771533, 14341.211233382264, 14734.189619571027, 15053.397864085315, 14152.22162781057, 14368.856311436752, 14407.711845762817, 14421.495247666282, 14444.494442694455, 13820.0, 14756.704865902837, 15252.389904403699, 15383.153926534149, 15903.443379481663, 10795.6221532246, 10952.890471095187, 11431.371274579978, 11560.190786644855, 11570.0, 11676.124290678063, 12046.819297710717, 12393.318367489876, 12418.254904705747, 12562.623121306375], "value": 8309.964043219727, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1511.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 111.0, 106.0, 110.0, 111.0, 113.0, 112.0, 110.0, 114.0, 109.0], "value": 109.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 115.0, 143.0, 184.0, 116.0, 142.0, 144.0, 118.0, 171.0, 118.0], "value": 139.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 161.0, 162.0, 161.0, 162.0, 162.0, 162.0, 164.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 76.0, 187.0, 77.0, 75.0, 75.0, 77.0, 184.0, 76.0], "value": 97.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 154.0, 83.0, 83.0, 84.0, 143.0, 84.0, 84.0, 146.0], "value": 103.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0, 118.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 152.0, 148.0, 148.0, 148.0, 148.0, 147.0, 147.0, 147.0], "value": 148.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 97.0, 95.0, 96.0, 95.0, 94.0, 95.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 51.0, 53.0, 54.0, 52.0, 55.0, 54.0, 53.0, 53.0], "value": 53.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 59.0, 59.0, 60.0, 59.0, 59.0, 59.0, 60.0, 59.0, 59.0], "value": 59.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 82.0, 72.0, 73.0, 75.0, 73.0, 72.0, 77.0, 79.0, 78.0], "value": 75.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 127.0, 123.0, 128.0, 118.0, 119.0, 119.0, 128.0, 155.0, 119.0], "value": 125.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 171.0, 157.0, 156.0, 157.0, 160.0, 172.0, 164.0, 160.0, 157.0], "value": 161.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 67.0, 63.0, 64.0, 62.0, 62.0, 63.0, 61.0, 65.0], "value": 63.3, "unit": "score"}]}]} 04:11:07 INFO - Return code: 0 04:11:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:11:07 ERROR - # TBPL SUCCESS # 04:11:07 INFO - Running post-action listener: _resource_record_post_action 04:11:07 INFO - [mozharness: 2016-08-18 11:11:07.122087Z] Finished run-tests step (success) 04:11:07 INFO - Running post-run listener: _resource_record_post_run 04:11:07 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 328851456; Read time: 32; Write time: 263288 04:11:07 INFO - TinderboxPrint: CPU usage
13.2% 04:11:07 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 32 04:11:07 INFO - TinderboxPrint: I/O write bytes / time
328,851,456 / 263,288 04:11:07 INFO - TinderboxPrint: CPU idle
8,225.2 (86.8%) 04:11:07 INFO - TinderboxPrint: CPU user
1,197.9 (12.6%) 04:11:07 INFO - TinderboxPrint: Swap in / out
0 / 0 04:11:07 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 77025280; Read time: 0; Write time: 88988 04:11:07 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 0; Write bytes: 249487360; Read time: 0; Write time: 174120 04:11:07 INFO - Running post-run listener: _upload_blobber_files 04:11:07 INFO - Blob upload gear active. 04:11:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:11:07 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 04:11:07 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-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:11:07 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-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:11:08 INFO - (blobuploader) - INFO - Open directory for files ... 04:11:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:11:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:11:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:11:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:11:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:11:12 INFO - (blobuploader) - INFO - Done attempting. 04:11:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:11:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:11:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:11:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:11:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:11:13 INFO - (blobuploader) - INFO - Done attempting. 04:11:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:11:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:11:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:11:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:11:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:11:13 INFO - (blobuploader) - INFO - Done attempting. 04:11:13 INFO - (blobuploader) - INFO - Iteration through files over. 04:11:13 INFO - Return code: 0 04:11:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:11:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:11:13 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/881a2921119ca85edf69fe85704dca5a0a5f9afcacb2200ac321984652acc57ab434ce2bd3ce0b74d05c5b60d2f40fe07bab94e4ba3f2d33ff9df2ad53dd618e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/88a33dd3bf20e1a75cd40fdac7bd3bcd9bc7c1627480d4cdc55e688c29888388514b987ced3feca1b4da49d34021b4aaca0744a5fc30709042a34816ed278fe4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d259aac07e32bb5275bbd13c01618b5b5df2003ce012527829b6b31ebf10469fa05b14f1fa58c5281a0e404655dbccbf8a604c78125b18d0ebcda92756df92c0"} 04:11:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:11:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:11:13 INFO - Contents: 04:11:13 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/881a2921119ca85edf69fe85704dca5a0a5f9afcacb2200ac321984652acc57ab434ce2bd3ce0b74d05c5b60d2f40fe07bab94e4ba3f2d33ff9df2ad53dd618e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/88a33dd3bf20e1a75cd40fdac7bd3bcd9bc7c1627480d4cdc55e688c29888388514b987ced3feca1b4da49d34021b4aaca0744a5fc30709042a34816ed278fe4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d259aac07e32bb5275bbd13c01618b5b5df2003ce012527829b6b31ebf10469fa05b14f1fa58c5281a0e404655dbccbf8a604c78125b18d0ebcda92756df92c0"} 04:11:13 INFO - Running post-run listener: copy_logs_to_upload_dir 04:11:13 INFO - Copying logs to upload dir... 04:11:13 INFO - mkdir: /builds/slave/test/build/upload/logs 04:11:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1676.550958 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 56 secs) (at 2016-08-18 04:11:13.423126) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-18 04:11:13.426480) ========= 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=03627c79f6bb3d1578c4a402000001ba-1471516994.737793-496500294 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-Aurora/sha512/881a2921119ca85edf69fe85704dca5a0a5f9afcacb2200ac321984652acc57ab434ce2bd3ce0b74d05c5b60d2f40fe07bab94e4ba3f2d33ff9df2ad53dd618e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/88a33dd3bf20e1a75cd40fdac7bd3bcd9bc7c1627480d4cdc55e688c29888388514b987ced3feca1b4da49d34021b4aaca0744a5fc30709042a34816ed278fe4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d259aac07e32bb5275bbd13c01618b5b5df2003ce012527829b6b31ebf10469fa05b14f1fa58c5281a0e404655dbccbf8a604c78125b18d0ebcda92756df92c0"} build_url:https://queue.taskcluster.net/v1/task/Lrz76RxxQ-CJWYAYHohH2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011265 build_url: 'https://queue.taskcluster.net/v1/task/Lrz76RxxQ-CJWYAYHohH2A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/881a2921119ca85edf69fe85704dca5a0a5f9afcacb2200ac321984652acc57ab434ce2bd3ce0b74d05c5b60d2f40fe07bab94e4ba3f2d33ff9df2ad53dd618e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/88a33dd3bf20e1a75cd40fdac7bd3bcd9bc7c1627480d4cdc55e688c29888388514b987ced3feca1b4da49d34021b4aaca0744a5fc30709042a34816ed278fe4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d259aac07e32bb5275bbd13c01618b5b5df2003ce012527829b6b31ebf10469fa05b14f1fa58c5281a0e404655dbccbf8a604c78125b18d0ebcda92756df92c0"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-18 04:11:13.456369) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 04:11:13.456753) ========= 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=03627c79f6bb3d1578c4a402000001ba-1471516994.737793-496500294 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004490 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 04:11:13.544606) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-18 04:11:13.545283) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-18 04:11:13.545894) ========= ========= Total master_lag: 0.20 =========