builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-034 starttime: 1470911350.06 results: success (0) buildid: 20160811004013 builduid: 1b40fb35f79e489c8cad5ea3564d7d77 revision: f5a9d33557dd860e74994a3a650e743569883cbb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-11 03:29:10.057151) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-11 03:29:10.057630) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-11 03:29:10.057916) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-11 03:29:10.073679) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 03:29:10.074068) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1470911349.86671-69503502 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-11 03:29:10-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2016-08-11 03:29:10 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.084990 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 03:29:10.174049) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 03:29:10.174592) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1470911349.86671-69503502 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014187 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 03:29:10.226454) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-11 03:29:10.226818) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev f5a9d33557dd860e74994a3a650e743569883cbb --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 f5a9d33557dd860e74994a3a650e743569883cbb --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=d6bbd613908ccac0c6c9cb47000001f7-1470911349.86671-69503502 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-11 03:29:10,372 truncating revision to first 12 chars 2016-08-11 03:29:10,372 Setting DEBUG logging. 2016-08-11 03:29:10,372 attempt 1/10 2016-08-11 03:29:10,372 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/f5a9d33557dd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-11 03:29:11,116 unpacking tar archive at: mozilla-aurora-f5a9d33557dd/testing/mozharness/ program finished with exit code 0 elapsedTime=1.105079 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-11 03:29:11.346303) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-11 03:29:11.346717) ========= script_repo_revision: f5a9d33557dd860e74994a3a650e743569883cbb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-11 03:29:11.347116) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-11 03:29:11.347408) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-11 03:29:11.359445) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 28 mins, 0 secs) (at 2016-08-11 03:29:11.359868) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=d6bbd613908ccac0c6c9cb47000001f7-1470911349.86671-69503502 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:29:11 INFO - MultiFileLogger online at 20160811 03:29:11 in /builds/slave/test 03:29:11 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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:29:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:29:11 INFO - {'append_to_log': False, 03:29:11 INFO - 'base_work_dir': '/builds/slave/test', 03:29:11 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:29:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:29:11 INFO - 'branch': 'Mozilla-Aurora', 03:29:11 INFO - 'buildbot_json_path': 'buildprops.json', 03:29:11 INFO - 'config_files': ('talos/linux_config.py',), 03:29:11 INFO - 'default_actions': ('clobber', 03:29:11 INFO - 'read-buildbot-config', 03:29:11 INFO - 'download-and-extract', 03:29:11 INFO - 'populate-webroot', 03:29:11 INFO - 'create-virtualenv', 03:29:11 INFO - 'install', 03:29:11 INFO - 'run-tests'), 03:29:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:29:11 INFO - 'download_minidump_stackwalk': True, 03:29:11 INFO - 'download_symbols': 'ondemand', 03:29:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:29:11 INFO - 'tooltool.py': '/tools/tooltool.py', 03:29:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:29:11 INFO - '/tools/misc-python/virtualenv.py')}, 03:29:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:29:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:29:11 INFO - 'installer_path': 'installer.exe', 03:29:11 INFO - 'log_level': 'info', 03:29:11 INFO - 'log_name': 'talos', 03:29:11 INFO - 'log_to_console': True, 03:29:11 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:29:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:29:11 INFO - 'opt_config_files': (), 03:29:11 INFO - 'pip_index': False, 03:29:11 INFO - 'sps_profile': False, 03:29:11 INFO - 'sps_profile_interval': 0, 03:29:11 INFO - 'suite': 'dromaeojs', 03:29:11 INFO - 'system_bits': '32', 03:29:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:29:11 INFO - 'title': 'talos-linux64-ix-034', 03:29:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:29:11 INFO - 'use_talos_json': True, 03:29:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:29:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:29:11 INFO - 'work_dir': 'build'} 03:29:11 INFO - [mozharness: 2016-08-11 10:29:11.598230Z] Running clobber step. 03:29:11 INFO - Running pre-action listener: _resource_record_pre_action 03:29:11 INFO - Running main action method: clobber 03:29:11 INFO - rmtree: /builds/slave/test/build 03:29:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:29:12 INFO - Running post-action listener: _resource_record_post_action 03:29:12 INFO - [mozharness: 2016-08-11 10:29:12.053357Z] Finished clobber step (success) 03:29:12 INFO - [mozharness: 2016-08-11 10:29:12.053466Z] Running read-buildbot-config step. 03:29:12 INFO - Running pre-action listener: _resource_record_pre_action 03:29:12 INFO - Running main action method: read_buildbot_config 03:29:12 INFO - Using buildbot properties: 03:29:12 INFO - { 03:29:12 INFO - "project": "", 03:29:12 INFO - "product": "firefox", 03:29:12 INFO - "script_repo_revision": "production", 03:29:12 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 03:29:12 INFO - "repository": "", 03:29:12 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 03:29:12 INFO - "buildid": "20160811004013", 03:29:12 INFO - "stage_platform": "linux64-pgo", 03:29:12 INFO - "basedir": "/builds/slave/test", 03:29:12 INFO - "nightly_build": "True", 03:29:12 INFO - "buildnumber": 459, 03:29:12 INFO - "slavename": "talos-linux64-ix-034", 03:29:12 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:29:12 INFO - "platform": "ubuntu64_hw", 03:29:12 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:29:12 INFO - "branch": "mozilla-aurora", 03:29:12 INFO - "repo_path": "releases/mozilla-aurora", 03:29:12 INFO - "revision": "f5a9d33557dd860e74994a3a650e743569883cbb", 03:29:12 INFO - "pgo_build": "True", 03:29:12 INFO - "builduid": "1b40fb35f79e489c8cad5ea3564d7d77", 03:29:12 INFO - "slavebuilddir": "test" 03:29:12 INFO - } 03:29:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/RIeDQBE4S_-4aBTCVQ7SHg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2. 03:29:12 INFO - Running post-action listener: _resource_record_post_action 03:29:12 INFO - [mozharness: 2016-08-11 10:29:12.056015Z] Finished read-buildbot-config step (success) 03:29:12 INFO - [mozharness: 2016-08-11 10:29:12.056106Z] Running download-and-extract step. 03:29:12 INFO - Running pre-action listener: _resource_record_pre_action 03:29:12 INFO - Running main action method: download_and_extract 03:29:12 INFO - mkdir: /builds/slave/test/build/tests 03:29:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:29:12 INFO - https://queue.taskcluster.net/v1/task/RIeDQBE4S_-4aBTCVQ7SHg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:29:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RIeDQBE4S_-4aBTCVQ7SHg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:29:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RIeDQBE4S_-4aBTCVQ7SHg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:29:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RIeDQBE4S_-4aBTCVQ7SHg/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:29:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RIeDQBE4S_-4aBTCVQ7SHg/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:29:12 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RIeDQBE4S_-4aBTCVQ7SHg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:29:12 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:29:12 INFO - retry: Failed, sleeping 30 seconds before retrying 03:29:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RIeDQBE4S_-4aBTCVQ7SHg/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:29:42 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RIeDQBE4S_-4aBTCVQ7SHg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:29:42 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:29:42 INFO - retry: Failed, sleeping 60 seconds before retrying 03:30:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RIeDQBE4S_-4aBTCVQ7SHg/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:30:42 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RIeDQBE4S_-4aBTCVQ7SHg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:30:42 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:30:42 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RIeDQBE4S_-4aBTCVQ7SHg/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:30:42 INFO - Caught exception: HTTP Error 404: Not Found 03:30:42 INFO - Caught exception: HTTP Error 404: Not Found 03:30:42 INFO - Caught exception: HTTP Error 404: Not Found 03:30:42 INFO - trying https://queue.taskcluster.net/v1/task/RIeDQBE4S_-4aBTCVQ7SHg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:30:42 INFO - Downloading https://queue.taskcluster.net/v1/task/RIeDQBE4S_-4aBTCVQ7SHg/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:30:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RIeDQBE4S_-4aBTCVQ7SHg/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:30:42 INFO - Downloaded 1361 bytes. 03:30:42 INFO - Reading from file /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:30:42 INFO - Using the following test package requirements: 03:30:42 INFO - {u'common': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 03:30:42 INFO - u'cppunittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:30:42 INFO - u'firefox-50.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:30:42 INFO - u'gtest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:30:42 INFO - u'firefox-50.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:30:42 INFO - u'jittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:30:42 INFO - u'jsshell-linux-x86_64.zip'], 03:30:42 INFO - u'mochitest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:30:42 INFO - u'firefox-50.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:30:42 INFO - u'mozbase': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 03:30:42 INFO - u'reftest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:30:42 INFO - u'firefox-50.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:30:42 INFO - u'talos': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:30:42 INFO - u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:30:42 INFO - u'web-platform': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:30:42 INFO - u'firefox-50.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:30:42 INFO - u'xpcshell': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:30:42 INFO - u'firefox-50.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:30:42 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:30:42 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:30:42 INFO - https://queue.taskcluster.net/v1/task/RIeDQBE4S_-4aBTCVQ7SHg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:30:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RIeDQBE4S_-4aBTCVQ7SHg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:30:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RIeDQBE4S_-4aBTCVQ7SHg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:30:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RIeDQBE4S_-4aBTCVQ7SHg/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:30:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RIeDQBE4S_-4aBTCVQ7SHg/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:30:42 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RIeDQBE4S_-4aBTCVQ7SHg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:30:42 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:30:42 INFO - retry: Failed, sleeping 30 seconds before retrying 03:31:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RIeDQBE4S_-4aBTCVQ7SHg/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:31:12 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RIeDQBE4S_-4aBTCVQ7SHg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:31:12 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:31:12 INFO - retry: Failed, sleeping 60 seconds before retrying 03:32:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RIeDQBE4S_-4aBTCVQ7SHg/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:32:12 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RIeDQBE4S_-4aBTCVQ7SHg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:32:12 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:32:12 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RIeDQBE4S_-4aBTCVQ7SHg/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:32:12 INFO - Caught exception: HTTP Error 404: Not Found 03:32:12 INFO - Caught exception: HTTP Error 404: Not Found 03:32:12 INFO - Caught exception: HTTP Error 404: Not Found 03:32:12 INFO - trying https://queue.taskcluster.net/v1/task/RIeDQBE4S_-4aBTCVQ7SHg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:32:12 INFO - Downloading https://queue.taskcluster.net/v1/task/RIeDQBE4S_-4aBTCVQ7SHg/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:32:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RIeDQBE4S_-4aBTCVQ7SHg/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:32:13 INFO - Downloaded 21766508 bytes. 03:32:13 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:32:13 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:32:14 INFO - Return code: 0 03:32:14 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:32: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:32:14 INFO - https://queue.taskcluster.net/v1/task/RIeDQBE4S_-4aBTCVQ7SHg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:32:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RIeDQBE4S_-4aBTCVQ7SHg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:32:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RIeDQBE4S_-4aBTCVQ7SHg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:32:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RIeDQBE4S_-4aBTCVQ7SHg/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:32:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RIeDQBE4S_-4aBTCVQ7SHg/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:32:14 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RIeDQBE4S_-4aBTCVQ7SHg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:32:14 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:32:14 INFO - retry: Failed, sleeping 30 seconds before retrying 03:32:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RIeDQBE4S_-4aBTCVQ7SHg/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:32:44 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RIeDQBE4S_-4aBTCVQ7SHg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:32:44 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:32:44 INFO - retry: Failed, sleeping 60 seconds before retrying 03:33:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RIeDQBE4S_-4aBTCVQ7SHg/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:33:45 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RIeDQBE4S_-4aBTCVQ7SHg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:33:45 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:33:45 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RIeDQBE4S_-4aBTCVQ7SHg/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:33:45 INFO - Caught exception: HTTP Error 404: Not Found 03:33:45 INFO - Caught exception: HTTP Error 404: Not Found 03:33:45 INFO - Caught exception: HTTP Error 404: Not Found 03:33:45 INFO - trying https://queue.taskcluster.net/v1/task/RIeDQBE4S_-4aBTCVQ7SHg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:33:45 INFO - Downloading https://queue.taskcluster.net/v1/task/RIeDQBE4S_-4aBTCVQ7SHg/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:33:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RIeDQBE4S_-4aBTCVQ7SHg/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:33:45 INFO - Downloaded 21766508 bytes. 03:33:45 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:33:45 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:33:47 INFO - Return code: 0 03:33:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:33:47 INFO - https://queue.taskcluster.net/v1/task/RIeDQBE4S_-4aBTCVQ7SHg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:33:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RIeDQBE4S_-4aBTCVQ7SHg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:33:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RIeDQBE4S_-4aBTCVQ7SHg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:33:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RIeDQBE4S_-4aBTCVQ7SHg/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:33:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RIeDQBE4S_-4aBTCVQ7SHg/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:33:47 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RIeDQBE4S_-4aBTCVQ7SHg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:33:47 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:33:47 INFO - retry: Failed, sleeping 30 seconds before retrying 03:34:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RIeDQBE4S_-4aBTCVQ7SHg/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:34:17 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RIeDQBE4S_-4aBTCVQ7SHg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:34:17 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:34:17 INFO - retry: Failed, sleeping 60 seconds before retrying 03:35:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RIeDQBE4S_-4aBTCVQ7SHg/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:35:17 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RIeDQBE4S_-4aBTCVQ7SHg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:35:17 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:35:17 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RIeDQBE4S_-4aBTCVQ7SHg/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:35:17 INFO - Caught exception: HTTP Error 404: Not Found 03:35:17 INFO - Caught exception: HTTP Error 404: Not Found 03:35:17 INFO - Caught exception: HTTP Error 404: Not Found 03:35:17 INFO - trying https://queue.taskcluster.net/v1/task/RIeDQBE4S_-4aBTCVQ7SHg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:35:17 INFO - Downloading https://queue.taskcluster.net/v1/task/RIeDQBE4S_-4aBTCVQ7SHg/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:35:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RIeDQBE4S_-4aBTCVQ7SHg/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:35:18 INFO - Downloaded 14413723 bytes. 03:35:18 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:35:18 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:35:18 INFO - Return code: 0 03:35: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:35:18 INFO - https://queue.taskcluster.net/v1/task/RIeDQBE4S_-4aBTCVQ7SHg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:35:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RIeDQBE4S_-4aBTCVQ7SHg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:35:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RIeDQBE4S_-4aBTCVQ7SHg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:35:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RIeDQBE4S_-4aBTCVQ7SHg/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:35:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RIeDQBE4S_-4aBTCVQ7SHg/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:35:18 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RIeDQBE4S_-4aBTCVQ7SHg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:35:18 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:35:18 INFO - retry: Failed, sleeping 30 seconds before retrying 03:35:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RIeDQBE4S_-4aBTCVQ7SHg/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:35:48 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RIeDQBE4S_-4aBTCVQ7SHg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:35:48 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:35:48 INFO - retry: Failed, sleeping 60 seconds before retrying 03:36:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RIeDQBE4S_-4aBTCVQ7SHg/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:36:48 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RIeDQBE4S_-4aBTCVQ7SHg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:36:48 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:36:48 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RIeDQBE4S_-4aBTCVQ7SHg/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:36:48 INFO - Caught exception: HTTP Error 404: Not Found 03:36:48 INFO - Caught exception: HTTP Error 404: Not Found 03:36:48 INFO - Caught exception: HTTP Error 404: Not Found 03:36:48 INFO - trying https://queue.taskcluster.net/v1/task/RIeDQBE4S_-4aBTCVQ7SHg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:36:48 INFO - Downloading https://queue.taskcluster.net/v1/task/RIeDQBE4S_-4aBTCVQ7SHg/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:36:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RIeDQBE4S_-4aBTCVQ7SHg/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:36:50 INFO - Downloaded 63744912 bytes. 03:36:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RIeDQBE4S_-4aBTCVQ7SHg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:36:50 INFO - mkdir: /builds/slave/test/properties 03:36:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:36:50 INFO - Writing to file /builds/slave/test/properties/build_url 03:36:50 INFO - Contents: 03:36:50 INFO - build_url:https://queue.taskcluster.net/v1/task/RIeDQBE4S_-4aBTCVQ7SHg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:36:50 INFO - Running post-action listener: _resource_record_post_action 03:36:50 INFO - Running post-action listener: set_extra_try_arguments 03:36:50 INFO - [mozharness: 2016-08-11 10:36:50.788189Z] Finished download-and-extract step (success) 03:36:50 INFO - [mozharness: 2016-08-11 10:36:50.788423Z] Running populate-webroot step. 03:36:50 INFO - Running pre-action listener: _resource_record_pre_action 03:36:50 INFO - Running main action method: populate_webroot 03:36:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:36:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:36:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:36:50 INFO - '--tppagecycles', 03:36:50 INFO - '7'], 03:36:50 INFO - 'tests': ['tsvgm']}}, 03:36:50 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:36:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:36:50 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:36:50 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:36:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:36:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:36:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:36:50 INFO - 'talos_options': ['--disable-e10s'], 03:36:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:36:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:36:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:36:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:36:50 INFO - 'talos_options': ['--disable-e10s'], 03:36:50 INFO - 'tests': ['damp', 'tps']}, 03:36:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:36:50 INFO - 'tests': ['damp', 'tps']}, 03:36:50 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:36:50 INFO - 'tests': ['dromaeo_dom']}, 03:36:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:36:50 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:36:50 INFO - 'tests': ['basic_compositor_video']}, 03:36:50 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:36:50 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:36:50 INFO - 'tests': ['a11yr', 03:36:50 INFO - 'ts_paint', 03:36:50 INFO - 'tpaint', 03:36:50 INFO - 'sessionrestore', 03:36:50 INFO - 'sessionrestore_no_auto_restore', 03:36:50 INFO - 'tabpaint']}, 03:36:50 INFO - 'other-e10s': {'tests': ['a11yr', 03:36:50 INFO - 'ts_paint', 03:36:50 INFO - 'tpaint', 03:36:50 INFO - 'sessionrestore', 03:36:50 INFO - 'sessionrestore_no_auto_restore', 03:36:50 INFO - 'tabpaint']}, 03:36:50 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:36:50 INFO - 'ts_paint', 03:36:50 INFO - 'tpaint', 03:36:50 INFO - 'sessionrestore', 03:36:50 INFO - 'sessionrestore_no_auto_restore', 03:36:50 INFO - 'tabpaint']}, 03:36:50 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:36:50 INFO - 'ts_paint', 03:36:50 INFO - 'tpaint', 03:36:50 INFO - 'sessionrestore', 03:36:50 INFO - 'sessionrestore_no_auto_restore', 03:36:50 INFO - 'tabpaint']}, 03:36:50 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:36:50 INFO - 'tests': ['a11yr', 03:36:50 INFO - 'ts_paint', 03:36:50 INFO - 'tpaint', 03:36:50 INFO - 'sessionrestore', 03:36:50 INFO - 'sessionrestore_no_auto_restore', 03:36:50 INFO - 'tabpaint']}, 03:36:50 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:36:50 INFO - 'tests': ['a11yr', 03:36:50 INFO - 'ts_paint', 03:36:50 INFO - 'tpaint', 03:36:50 INFO - 'sessionrestore', 03:36:50 INFO - 'sessionrestore_no_auto_restore', 03:36:50 INFO - 'tabpaint']}, 03:36:50 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:36:50 INFO - 'tests': ['tsvgx', 03:36:50 INFO - 'tsvgr_opacity', 03:36:50 INFO - 'tart', 03:36:50 INFO - 'tscrollx', 03:36:50 INFO - 'cart']}, 03:36:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:36:50 INFO - 'tsvgr_opacity', 03:36:50 INFO - 'tart', 03:36:50 INFO - 'tscrollx', 03:36:50 INFO - 'cart']}, 03:36:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:36:50 INFO - 'talos_options': ['--disable-e10s'], 03:36:50 INFO - 'tests': ['tp5o']}, 03:36:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:36:50 INFO - 'tests': ['tp5o']}, 03:36:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:36:50 INFO - 'talos_options': ['--disable-e10s', 03:36:50 INFO - '--xperf_path', 03:36:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:36:50 INFO - 'tests': ['tp5n']}, 03:36:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:36:50 INFO - 'talos_options': ['--xperf_path', 03:36:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:36:50 INFO - 'tests': ['tp5n']}}, 03:36:50 INFO - 'talos.zip': {'path': '', 03:36:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:36:50 INFO - Running post-action listener: _resource_record_post_action 03:36:50 INFO - [mozharness: 2016-08-11 10:36:50.810081Z] Finished populate-webroot step (success) 03:36:50 INFO - [mozharness: 2016-08-11 10:36:50.810172Z] Running create-virtualenv step. 03:36:50 INFO - Running pre-action listener: _resource_record_pre_action 03:36:50 INFO - Running main action method: create_virtualenv 03:36:50 INFO - Creating virtualenv /builds/slave/test/build/venv 03:36:50 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:36:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:36:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:36:50 INFO - Using real prefix '/usr' 03:36:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:36:51 INFO - Installing distribute.............................................................................................................................................................................................done. 03:36:53 INFO - Installing pip.................done. 03:36:53 INFO - Return code: 0 03:36:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:36: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:36:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36: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:36:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x286b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b2c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b2a3b0>, '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 0x2b2b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b2b740>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1470911349.86671-69503502', '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:36:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:36:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:36:53 INFO - Using env: {'DISPLAY': ':0', 03:36:53 INFO - 'HOME': '/home/cltbld', 03:36:53 INFO - 'LANG': 'en_US.UTF-8', 03:36:53 INFO - 'LANGUAGE': 'en_US:en', 03:36:53 INFO - 'LOGNAME': 'cltbld', 03:36:53 INFO - 'MAIL': '/var/mail/cltbld', 03:36:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:53 INFO - 'MOZ_NO_REMOTE': '1', 03:36:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:36:53 INFO - 'NO_EM_RESTART': '1', 03:36:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:36:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:53 INFO - 'PWD': '/builds/slave/test', 03:36:53 INFO - 'SHELL': '/bin/bash', 03:36:53 INFO - 'SHLVL': '1', 03:36:53 INFO - 'TERM': 'linux', 03:36:53 INFO - 'TMOUT': '86400', 03:36:53 INFO - 'USER': 'cltbld', 03:36:53 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1470911349.86671-69503502', 03:36:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:53 INFO - '_': '/tools/buildbot/bin/python'} 03:36:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:53 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:36:53 INFO - Cleaning up... 03:36:53 INFO - Return code: 0 03:36:53 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:36: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:36:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36: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:36:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x286b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b2c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b2a3b0>, '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 0x2b2b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b2b740>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1470911349.86671-69503502', '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:36:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:36:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:36:53 INFO - Using env: {'DISPLAY': ':0', 03:36:53 INFO - 'HOME': '/home/cltbld', 03:36:53 INFO - 'LANG': 'en_US.UTF-8', 03:36:53 INFO - 'LANGUAGE': 'en_US:en', 03:36:53 INFO - 'LOGNAME': 'cltbld', 03:36:53 INFO - 'MAIL': '/var/mail/cltbld', 03:36:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:53 INFO - 'MOZ_NO_REMOTE': '1', 03:36:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:36:53 INFO - 'NO_EM_RESTART': '1', 03:36:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:36:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:53 INFO - 'PWD': '/builds/slave/test', 03:36:53 INFO - 'SHELL': '/bin/bash', 03:36:53 INFO - 'SHLVL': '1', 03:36:53 INFO - 'TERM': 'linux', 03:36:53 INFO - 'TMOUT': '86400', 03:36:53 INFO - 'USER': 'cltbld', 03:36:53 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1470911349.86671-69503502', 03:36:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:53 INFO - '_': '/tools/buildbot/bin/python'} 03:36:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:53 INFO - Downloading/unpacking psutil>=3.1.1 03:36:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:36:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:36:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:36:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:36:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:36:55 INFO - Installing collected packages: psutil 03:36:55 INFO - Running setup.py install for psutil 03:36:55 INFO - building 'psutil._psutil_linux' extension 03:36:55 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:36:56 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:36:56 INFO - building 'psutil._psutil_posix' extension 03:36:56 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:36:56 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:36:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:36:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:36:56 INFO - Successfully installed psutil 03:36:56 INFO - Cleaning up... 03:36:56 INFO - Return code: 0 03:36:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:36:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:36:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:36:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:56 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 0x286b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b2c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b2a3b0>, '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 0x2b2b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b2b740>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1470911349.86671-69503502', '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:36:56 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:36:56 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:36:56 INFO - Using env: {'DISPLAY': ':0', 03:36:56 INFO - 'HOME': '/home/cltbld', 03:36:56 INFO - 'LANG': 'en_US.UTF-8', 03:36:56 INFO - 'LANGUAGE': 'en_US:en', 03:36:56 INFO - 'LOGNAME': 'cltbld', 03:36:56 INFO - 'MAIL': '/var/mail/cltbld', 03:36:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:56 INFO - 'MOZ_NO_REMOTE': '1', 03:36:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:36:56 INFO - 'NO_EM_RESTART': '1', 03:36:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:36:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:56 INFO - 'PWD': '/builds/slave/test', 03:36:56 INFO - 'SHELL': '/bin/bash', 03:36:56 INFO - 'SHLVL': '1', 03:36:56 INFO - 'TERM': 'linux', 03:36:56 INFO - 'TMOUT': '86400', 03:36:56 INFO - 'USER': 'cltbld', 03:36:56 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1470911349.86671-69503502', 03:36:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:56 INFO - '_': '/tools/buildbot/bin/python'} 03:36:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:36:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:36:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:36:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:36:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:36:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:36:58 INFO - Installing collected packages: mozsystemmonitor 03:36:58 INFO - Running setup.py install for mozsystemmonitor 03:36:58 INFO - Successfully installed mozsystemmonitor 03:36:58 INFO - Cleaning up... 03:36:58 INFO - Return code: 0 03:36:58 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:36:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:36:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:36:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x286b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b2c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b2a3b0>, '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 0x2b2b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b2b740>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1470911349.86671-69503502', '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:36:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:36:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:36:58 INFO - Using env: {'DISPLAY': ':0', 03:36:58 INFO - 'HOME': '/home/cltbld', 03:36:58 INFO - 'LANG': 'en_US.UTF-8', 03:36:58 INFO - 'LANGUAGE': 'en_US:en', 03:36:58 INFO - 'LOGNAME': 'cltbld', 03:36:58 INFO - 'MAIL': '/var/mail/cltbld', 03:36:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:58 INFO - 'MOZ_NO_REMOTE': '1', 03:36:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:36:58 INFO - 'NO_EM_RESTART': '1', 03:36:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:36:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:58 INFO - 'PWD': '/builds/slave/test', 03:36:58 INFO - 'SHELL': '/bin/bash', 03:36:58 INFO - 'SHLVL': '1', 03:36:58 INFO - 'TERM': 'linux', 03:36:58 INFO - 'TMOUT': '86400', 03:36:58 INFO - 'USER': 'cltbld', 03:36:58 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1470911349.86671-69503502', 03:36:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:58 INFO - '_': '/tools/buildbot/bin/python'} 03:36:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:58 INFO - Downloading/unpacking jsonschema==2.5.1 03:36:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:36:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:36:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:37:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:37:00 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:37:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:37:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:37:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:37:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:37:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:37:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:37:00 INFO - Downloading functools32-3.2.3-2.tar.gz 03:37:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:37:00 INFO - warning: no files found matching '*.txt' 03:37:00 INFO - no previously-included directories found matching 'build' 03:37:00 INFO - no previously-included directories found matching 'dist' 03:37:01 INFO - no previously-included directories found matching '.git*' 03:37:01 INFO - Installing collected packages: jsonschema, functools32 03:37:01 INFO - Running setup.py install for functools32 03:37:01 INFO - warning: no files found matching '*.txt' 03:37:01 INFO - no previously-included directories found matching 'build' 03:37:01 INFO - no previously-included directories found matching 'dist' 03:37:01 INFO - no previously-included directories found matching '.git*' 03:37:01 INFO - Successfully installed jsonschema functools32 03:37:01 INFO - Cleaning up... 03:37:01 INFO - Return code: 0 03:37:01 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:37:01 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:37:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:01 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:37:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:01 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 0x286b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b2c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b2a3b0>, '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 0x2b2b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b2b740>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1470911349.86671-69503502', '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:37:01 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:37:01 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:37:01 INFO - Using env: {'DISPLAY': ':0', 03:37:01 INFO - 'HOME': '/home/cltbld', 03:37:01 INFO - 'LANG': 'en_US.UTF-8', 03:37:01 INFO - 'LANGUAGE': 'en_US:en', 03:37:01 INFO - 'LOGNAME': 'cltbld', 03:37:01 INFO - 'MAIL': '/var/mail/cltbld', 03:37:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:01 INFO - 'MOZ_NO_REMOTE': '1', 03:37:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:37:01 INFO - 'NO_EM_RESTART': '1', 03:37:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:37:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:01 INFO - 'PWD': '/builds/slave/test', 03:37:01 INFO - 'SHELL': '/bin/bash', 03:37:01 INFO - 'SHLVL': '1', 03:37:01 INFO - 'TERM': 'linux', 03:37:01 INFO - 'TMOUT': '86400', 03:37:01 INFO - 'USER': 'cltbld', 03:37:01 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1470911349.86671-69503502', 03:37:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:01 INFO - '_': '/tools/buildbot/bin/python'} 03:37:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:01 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:37:01 INFO - Cleaning up... 03:37:01 INFO - Return code: 0 03:37:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:37:01 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:37:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:01 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:37:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:01 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 0x286b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b2c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b2a3b0>, '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 0x2b2b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b2b740>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1470911349.86671-69503502', '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:37:01 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:37:01 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:37:01 INFO - Using env: {'DISPLAY': ':0', 03:37:01 INFO - 'HOME': '/home/cltbld', 03:37:01 INFO - 'LANG': 'en_US.UTF-8', 03:37:01 INFO - 'LANGUAGE': 'en_US:en', 03:37:01 INFO - 'LOGNAME': 'cltbld', 03:37:01 INFO - 'MAIL': '/var/mail/cltbld', 03:37:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:01 INFO - 'MOZ_NO_REMOTE': '1', 03:37:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:37:01 INFO - 'NO_EM_RESTART': '1', 03:37:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:37:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:01 INFO - 'PWD': '/builds/slave/test', 03:37:01 INFO - 'SHELL': '/bin/bash', 03:37:01 INFO - 'SHLVL': '1', 03:37:01 INFO - 'TERM': 'linux', 03:37:01 INFO - 'TMOUT': '86400', 03:37:01 INFO - 'USER': 'cltbld', 03:37:01 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1470911349.86671-69503502', 03:37:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:01 INFO - '_': '/tools/buildbot/bin/python'} 03:37:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:01 INFO - Downloading/unpacking blobuploader==1.2.4 03:37:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:37:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:37:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:37:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:37:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:37:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:37:03 INFO - Downloading blobuploader-1.2.4.tar.gz 03:37:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:37:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:37:03 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:37:03 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:37:03 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:37:03 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:37:03 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:37:03 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:37:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:37:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:37: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:37: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:37: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:37: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:37: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:37: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:37:04 INFO - Downloading docopt-0.6.1.tar.gz 03:37:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:37:04 INFO - Installing collected packages: blobuploader, requests, docopt 03:37:04 INFO - Running setup.py install for blobuploader 03:37:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:37:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:37:04 INFO - Running setup.py install for requests 03:37:04 INFO - Running setup.py install for docopt 03:37:04 INFO - Successfully installed blobuploader requests docopt 03:37:04 INFO - Cleaning up... 03:37:04 INFO - Return code: 0 03:37:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:37: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:37:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37: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:37:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:04 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 0x286b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b2c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b2a3b0>, '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 0x2b2b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b2b740>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1470911349.86671-69503502', '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:37:04 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:37:04 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:37:04 INFO - Using env: {'DISPLAY': ':0', 03:37:04 INFO - 'HOME': '/home/cltbld', 03:37:04 INFO - 'LANG': 'en_US.UTF-8', 03:37:04 INFO - 'LANGUAGE': 'en_US:en', 03:37:04 INFO - 'LOGNAME': 'cltbld', 03:37:04 INFO - 'MAIL': '/var/mail/cltbld', 03:37:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:04 INFO - 'MOZ_NO_REMOTE': '1', 03:37:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:37:04 INFO - 'NO_EM_RESTART': '1', 03:37:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:37:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:04 INFO - 'PWD': '/builds/slave/test', 03:37:04 INFO - 'SHELL': '/bin/bash', 03:37:04 INFO - 'SHLVL': '1', 03:37:04 INFO - 'TERM': 'linux', 03:37:04 INFO - 'TMOUT': '86400', 03:37:04 INFO - 'USER': 'cltbld', 03:37:04 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1470911349.86671-69503502', 03:37:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:04 INFO - '_': '/tools/buildbot/bin/python'} 03:37:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:37:05 INFO - Running setup.py (path:/tmp/pip-Erttpw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:37:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:37:05 INFO - Running setup.py (path:/tmp/pip-8xNfjP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:37:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:37:05 INFO - Running setup.py (path:/tmp/pip-vP8hSw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:37:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:37:05 INFO - Running setup.py (path:/tmp/pip-l_M_1c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:37:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:37:05 INFO - Running setup.py (path:/tmp/pip-Ll7yMK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:37:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:37:05 INFO - Running setup.py (path:/tmp/pip-m28t0J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:37:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:37:05 INFO - Running setup.py (path:/tmp/pip-pRSYuO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:37:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:37:05 INFO - Running setup.py (path:/tmp/pip-rsv9dI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:37:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:37:05 INFO - Running setup.py (path:/tmp/pip-5tlymk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:37:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:37:05 INFO - Running setup.py (path:/tmp/pip-TkU5JD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:37:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:37:05 INFO - Running setup.py (path:/tmp/pip-qtjVt0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:37:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:37:05 INFO - Running setup.py (path:/tmp/pip-yonGWC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:37:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:37:05 INFO - Running setup.py (path:/tmp/pip-ZdwkH9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:37:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:37:06 INFO - Running setup.py (path:/tmp/pip-LQUuEC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:37:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:37:06 INFO - Running setup.py (path:/tmp/pip-0jsgnN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:37:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:37:06 INFO - Running setup.py (path:/tmp/pip-CUJq42-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:37:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:37:06 INFO - Running setup.py (path:/tmp/pip-qvLTR5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:37:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:37:06 INFO - Running setup.py install for manifestparser 03:37:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:37:06 INFO - Running setup.py install for mozcrash 03:37:06 INFO - Running setup.py install for mozdebug 03:37:06 INFO - Running setup.py install for mozdevice 03:37:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:37:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:37:06 INFO - Running setup.py install for mozfile 03:37:06 INFO - Running setup.py install for mozhttpd 03:37:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:37:06 INFO - Running setup.py install for mozinfo 03:37:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:37:07 INFO - Running setup.py install for mozInstall 03:37:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:37:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:37:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:37:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:37:07 INFO - Running setup.py install for mozleak 03:37:07 INFO - Running setup.py install for mozlog 03:37:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:37:07 INFO - Running setup.py install for moznetwork 03:37:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:37:07 INFO - Running setup.py install for mozprocess 03:37:07 INFO - Running setup.py install for mozprofile 03:37:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:37:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:37:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:37:07 INFO - Running setup.py install for mozrunner 03:37:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:37:07 INFO - Running setup.py install for mozscreenshot 03:37:07 INFO - Running setup.py install for moztest 03:37:08 INFO - Running setup.py install for mozversion 03:37:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:37:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:37:08 INFO - Cleaning up... 03:37:08 INFO - Return code: 0 03:37:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:37:08 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:37:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:08 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:37:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:08 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 0x286b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b2c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b2a3b0>, '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 0x2b2b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b2b740>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1470911349.86671-69503502', '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:37:08 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:37:08 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:37:08 INFO - Using env: {'DISPLAY': ':0', 03:37:08 INFO - 'HOME': '/home/cltbld', 03:37:08 INFO - 'LANG': 'en_US.UTF-8', 03:37:08 INFO - 'LANGUAGE': 'en_US:en', 03:37:08 INFO - 'LOGNAME': 'cltbld', 03:37:08 INFO - 'MAIL': '/var/mail/cltbld', 03:37:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:08 INFO - 'MOZ_NO_REMOTE': '1', 03:37:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:37:08 INFO - 'NO_EM_RESTART': '1', 03:37:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:37:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:08 INFO - 'PWD': '/builds/slave/test', 03:37:08 INFO - 'SHELL': '/bin/bash', 03:37:08 INFO - 'SHLVL': '1', 03:37:08 INFO - 'TERM': 'linux', 03:37:08 INFO - 'TMOUT': '86400', 03:37:08 INFO - 'USER': 'cltbld', 03:37:08 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1470911349.86671-69503502', 03:37:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:08 INFO - '_': '/tools/buildbot/bin/python'} 03:37:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:37:08 INFO - Running setup.py (path:/tmp/pip-26T1wO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:37:08 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:37:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:37:08 INFO - Running setup.py (path:/tmp/pip-vTXmhJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:37:08 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:37:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:37:08 INFO - Running setup.py (path:/tmp/pip-1Zrr_A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:37:08 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:37:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:37:08 INFO - Running setup.py (path:/tmp/pip-Wfp2ZG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:37:08 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:37:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:37:08 INFO - Running setup.py (path:/tmp/pip-FOyssi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:37:08 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:37:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:37:08 INFO - Running setup.py (path:/tmp/pip-SaiOuS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:37:08 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:37:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:37:08 INFO - Running setup.py (path:/tmp/pip-usm3X5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:37:08 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:37:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:37:08 INFO - Running setup.py (path:/tmp/pip-700t7Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:37:08 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:37:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:37:08 INFO - Running setup.py (path:/tmp/pip-SkyMX4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:37:09 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:37:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:37:09 INFO - Running setup.py (path:/tmp/pip-RfG3BG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:37:09 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:37:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:37:09 INFO - Running setup.py (path:/tmp/pip-MGYDQ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:37:09 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:37:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:37:09 INFO - Running setup.py (path:/tmp/pip-ED92x3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:37:09 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:37:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:37:09 INFO - Running setup.py (path:/tmp/pip-X2VTyy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:37:09 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:37:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:37:09 INFO - Running setup.py (path:/tmp/pip-XUNVR1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:37:09 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:37:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:37:09 INFO - Running setup.py (path:/tmp/pip-VVSToM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:37:09 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:37:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:37:09 INFO - Running setup.py (path:/tmp/pip-boWIrk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:37:09 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:37:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:37:09 INFO - Running setup.py (path:/tmp/pip-4PURsx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:37:09 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:37:09 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:37:09 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:37:09 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:37:09 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:37:09 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:37:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:37: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:37: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:37: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:37: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:37: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:37: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:37:11 INFO - Downloading blessings-1.6.tar.gz 03:37:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:37:11 INFO - Installing collected packages: blessings 03:37:11 INFO - Running setup.py install for blessings 03:37:11 INFO - Successfully installed blessings 03:37:11 INFO - Cleaning up... 03:37:11 INFO - Return code: 0 03:37:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:37:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:37:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:37:11 INFO - Reading from file tmpfile_stdout 03:37:11 INFO - Current package versions: 03:37:11 INFO - argparse == 1.2.1 03:37:11 INFO - blessings == 1.6 03:37:11 INFO - blobuploader == 1.2.4 03:37:11 INFO - docopt == 0.6.1 03:37:11 INFO - functools32 == 3.2.3-2 03:37:11 INFO - jsonschema == 2.5.1 03:37:11 INFO - manifestparser == 1.1 03:37:11 INFO - mozInstall == 1.12 03:37:11 INFO - mozcrash == 0.17 03:37:11 INFO - mozdebug == 0.1 03:37:11 INFO - mozdevice == 0.48 03:37:11 INFO - mozfile == 1.2 03:37:11 INFO - mozhttpd == 0.7 03:37:11 INFO - mozinfo == 0.9 03:37:11 INFO - mozleak == 0.1 03:37:11 INFO - mozlog == 3.3 03:37:11 INFO - moznetwork == 0.27 03:37:11 INFO - mozprocess == 0.23 03:37:11 INFO - mozprofile == 0.28 03:37:11 INFO - mozrunner == 6.12 03:37:11 INFO - mozscreenshot == 0.1 03:37:11 INFO - mozsystemmonitor == 0.3 03:37:11 INFO - moztest == 0.7 03:37:11 INFO - mozversion == 1.4 03:37:11 INFO - psutil == 3.1.1 03:37:11 INFO - requests == 1.2.3 03:37:11 INFO - wsgiref == 0.1.2 03:37:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:37:11 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:37:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:11 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:37:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:11 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 0x286b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b2c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b2a3b0>, '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 0x2b2b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b2b740>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1470911349.86671-69503502', '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:37:11 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:37:11 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:37:11 INFO - Using env: {'DISPLAY': ':0', 03:37:11 INFO - 'HOME': '/home/cltbld', 03:37:11 INFO - 'LANG': 'en_US.UTF-8', 03:37:11 INFO - 'LANGUAGE': 'en_US:en', 03:37:11 INFO - 'LOGNAME': 'cltbld', 03:37:11 INFO - 'MAIL': '/var/mail/cltbld', 03:37:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:11 INFO - 'MOZ_NO_REMOTE': '1', 03:37:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:37:11 INFO - 'NO_EM_RESTART': '1', 03:37:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:37:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:11 INFO - 'PWD': '/builds/slave/test', 03:37:11 INFO - 'SHELL': '/bin/bash', 03:37:11 INFO - 'SHLVL': '1', 03:37:11 INFO - 'TERM': 'linux', 03:37:11 INFO - 'TMOUT': '86400', 03:37:11 INFO - 'USER': 'cltbld', 03:37:11 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1470911349.86671-69503502', 03:37:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:11 INFO - '_': '/tools/buildbot/bin/python'} 03:37:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:12 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:37:12 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:37:12 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:37:12 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:37:12 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:37:12 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:37:12 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:37:12 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:37:12 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:37:12 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:37:12 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:37:12 INFO - Cleaning up... 03:37:12 INFO - Return code: 0 03:37:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:37:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:37:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:37:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:12 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 0x286b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b2c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b2a3b0>, '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 0x2b2b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b2b740>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1470911349.86671-69503502', '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:37:12 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:37:12 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:37:12 INFO - Using env: {'DISPLAY': ':0', 03:37:12 INFO - 'HOME': '/home/cltbld', 03:37:12 INFO - 'LANG': 'en_US.UTF-8', 03:37:12 INFO - 'LANGUAGE': 'en_US:en', 03:37:12 INFO - 'LOGNAME': 'cltbld', 03:37:12 INFO - 'MAIL': '/var/mail/cltbld', 03:37:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:12 INFO - 'MOZ_NO_REMOTE': '1', 03:37:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:37:12 INFO - 'NO_EM_RESTART': '1', 03:37:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:37:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:12 INFO - 'PWD': '/builds/slave/test', 03:37:12 INFO - 'SHELL': '/bin/bash', 03:37:12 INFO - 'SHLVL': '1', 03:37:12 INFO - 'TERM': 'linux', 03:37:12 INFO - 'TMOUT': '86400', 03:37:12 INFO - 'USER': 'cltbld', 03:37:12 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1470911349.86671-69503502', 03:37:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:12 INFO - '_': '/tools/buildbot/bin/python'} 03:37:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:12 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:37:12 INFO - Cleaning up... 03:37:12 INFO - Return code: 0 03:37:12 INFO - Running post-action listener: _resource_record_post_action 03:37:12 INFO - Running post-action listener: _start_resource_monitoring 03:37:12 INFO - Starting resource monitoring. 03:37:12 INFO - [mozharness: 2016-08-11 10:37:12.413802Z] Finished create-virtualenv step (success) 03:37:12 INFO - [mozharness: 2016-08-11 10:37:12.414229Z] Running install step. 03:37:12 INFO - Running pre-action listener: _resource_record_pre_action 03:37:12 INFO - Running main action method: install 03:37:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:37:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:37:12 INFO - Reading from file tmpfile_stdout 03:37:12 INFO - Detecting whether we're running mozinstall >=1.0... 03:37:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:37:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:37:12 INFO - Reading from file tmpfile_stdout 03:37:12 INFO - Output received: 03:37:12 INFO - Usage: mozinstall [options] installer 03:37:12 INFO - Options: 03:37:12 INFO - -h, --help show this help message and exit 03:37:12 INFO - -d DEST, --destination=DEST 03:37:12 INFO - Directory to install application into. [default: 03:37:12 INFO - "/builds/slave/test"] 03:37:12 INFO - --app=APP Application being installed. [default: firefox] 03:37:12 INFO - mkdir: /builds/slave/test/build/application 03:37:12 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:37:12 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:37:29 INFO - Reading from file tmpfile_stdout 03:37:29 INFO - Output received: 03:37:29 INFO - /builds/slave/test/build/application/firefox/firefox 03:37:29 INFO - Running post-action listener: _resource_record_post_action 03:37:29 INFO - [mozharness: 2016-08-11 10:37:29.366462Z] Finished install step (success) 03:37:29 INFO - [mozharness: 2016-08-11 10:37:29.366736Z] Running run-tests step. 03:37:29 INFO - Running pre-action listener: _resource_record_pre_action 03:37:29 INFO - Running main action method: run_tests 03:37:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:37:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:37:29 INFO - Python 2.7.3 03:37:29 INFO - Return code: 0 03:37:29 INFO - grabbing minidump binary from tooltool 03:37:29 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:37:29 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 0x2b2a3b0>, '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 0x2b2b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b2b740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:37:29 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:37:29 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:37:29 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:37:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:37:29 INFO - Return code: 0 03:37:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:37:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:37:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:37:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:37:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:37:29 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RIeDQBE4S_-4aBTCVQ7SHg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 03:37:29 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RIeDQBE4S_-4aBTCVQ7SHg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-034 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 03:37:29 INFO - Using env: {'DISPLAY': ':0', 03:37:29 INFO - 'HOME': '/home/cltbld', 03:37:29 INFO - 'LANG': 'en_US.UTF-8', 03:37:29 INFO - 'LANGUAGE': 'en_US:en', 03:37:29 INFO - 'LOGNAME': 'cltbld', 03:37:29 INFO - 'MAIL': '/var/mail/cltbld', 03:37:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:37:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:37:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:29 INFO - 'MOZ_NO_REMOTE': '1', 03:37:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:37:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:37:29 INFO - 'NO_EM_RESTART': '1', 03:37:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:37:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:29 INFO - 'PWD': '/builds/slave/test', 03:37:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:37:29 INFO - 'SHELL': '/bin/bash', 03:37:29 INFO - 'SHLVL': '1', 03:37:29 INFO - 'TERM': 'linux', 03:37:29 INFO - 'TMOUT': '86400', 03:37:29 INFO - 'USER': 'cltbld', 03:37:29 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1470911349.86671-69503502', 03:37:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:29 INFO - '_': '/tools/buildbot/bin/python'} 03:37:29 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RIeDQBE4S_-4aBTCVQ7SHg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 03:37:29 INFO - mozversion application_buildid: 20160811004013 03:37:29 INFO - mozversion application_changeset: f5a9d33557dd860e74994a3a650e743569883cbb 03:37:29 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:37:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:37:29 INFO - mozversion application_name: Firefox 03:37:29 INFO - mozversion application_remotingname: firefox-dev 03:37:29 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:37:29 INFO - mozversion application_vendor: Mozilla 03:37:29 INFO - mozversion application_version: 50.0a2 03:37:29 INFO - mozversion platform_buildid: 20160811004013 03:37:29 INFO - mozversion platform_changeset: f5a9d33557dd860e74994a3a650e743569883cbb 03:37:29 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:37:29 INFO - mozversion platform_version: 50.0a2 03:37:29 INFO - using testdate: 1470911849 03:37:29 INFO - actual date: 1470911849 03:37:29 INFO - starting webserver on 'localhost:47637' 03:37:29 INFO - SUITE-START | Running 2 tests 03:37:29 INFO - TEST-START | dromaeo_css 03:37:29 INFO - operating with platform_type : linux_ 03:37:29 INFO - Initialising browser for dromaeo_css test... 03:37:29 INFO - TEST-INFO | started process 20784 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9rw2Wk/profile http://localhost:47637/getInfo.html) 03:37:33 INFO - PROCESS | 20784 | __metrics Screen width/height:1600/1200 03:37:33 INFO - PROCESS | 20784 | colorDepth:24 03:37:33 INFO - PROCESS | 20784 | Browser inner width/height: 1024/697 03:37:33 INFO - PROCESS | 20784 | __metrics 03:37:34 INFO - PROCESS | 20784 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:37:34 INFO - PROCESS | 20784 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:37:35 INFO - TEST-INFO | 20784: exit 0 03:37:35 INFO - Browser initialized. 03:37:35 INFO - Running cycle 1/1 for dromaeo_css test... 03:37:35 INFO - TEST-INFO | started process 20871 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9rw2Wk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:37:47 INFO - PROCESS | 20871 | RSS: Main: 145252352 03:37:47 INFO - PROCESS | 20871 | 03:38:38 INFO - PROCESS | 20871 | 1470911918076 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:40:47 INFO - PROCESS | 20871 | Cycle 1(1): loaded http://localhost:47637/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47637/tests/dromaeo/cssquery-ext.html) 03:40:48 INFO - PROCESS | 20871 | RSS: Main: 221921280 03:40:48 INFO - PROCESS | 20871 | 03:43:50 INFO - PROCESS | 20871 | Cycle 1(1): loaded http://localhost:47637/tests/dromaeo/cssquery-ext.html (next: http://localhost:47637/tests/dromaeo/cssquery-jquery.html) 03:43:51 INFO - PROCESS | 20871 | RSS: Main: 237080576 03:43:51 INFO - PROCESS | 20871 | 03:46:53 INFO - PROCESS | 20871 | Cycle 1(1): loaded http://localhost:47637/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47637/tests/dromaeo/cssquery-mootools.html) 03:46:53 INFO - PROCESS | 20871 | RSS: Main: 176340992 03:46:53 INFO - PROCESS | 20871 | 03:49:55 INFO - PROCESS | 20871 | Cycle 1(1): loaded http://localhost:47637/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47637/tests/dromaeo/cssquery-prototype.html) 03:49:56 INFO - PROCESS | 20871 | RSS: Main: 225361920 03:49:56 INFO - PROCESS | 20871 | 03:52:59 INFO - PROCESS | 20871 | Cycle 1(1): loaded http://localhost:47637/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47637/tests/dromaeo/cssquery-yui.html) 03:52:59 INFO - PROCESS | 20871 | RSS: Main: 173821952 03:52:59 INFO - PROCESS | 20871 | 03:56:02 INFO - PROCESS | 20871 | Cycle 1(1): loaded http://localhost:47637/tests/dromaeo/cssquery-yui.html (next: http://localhost:47637/tests/dromaeo/cssquery-dojo.html) 03:56:02 INFO - PROCESS | 20871 | RSS: Main: 260145152 03:56:02 INFO - PROCESS | 20871 | 03:56:02 INFO - PROCESS | 20871 | __start_tp_report 03:56:02 INFO - PROCESS | 20871 | _x_x_mozilla_page_load 03:56:02 INFO - PROCESS | 20871 | _x_x_mozilla_page_load_details 03:56:02 INFO - PROCESS | 20871 | |i|pagename|runs| 03:56:02 INFO - PROCESS | 20871 | |0;dojo.html;3230.45082336003;3236.1262459136033;3247.107045562471;3270.640229574745;3274.0505253476476;5613.550915926721;5663.773449062043;5685.8578535536635;5687.459691329323;5709.371969083408;5643.463870932265;5688.232088668028;5707.571932105088;5730.68481233532;5743.942560574393;5044.82343117991;5127.615428842833;5144.305518754976;5154.948450515484;5216.3218781558535;5205.349331333583;5257.263983042377;5259.447757985414;5260.8684782880355;5261.921071183935;5118.6416950813455;5121.641485096045;5159.71621560814;5176.55999240065;5244.292020577231;5204.063268611649;5262.578993680516;5273.314469119028;5276.234945932818;5306.973465132688;5105.795768169269;5107.412647545542;5129.230615407681;5176.327077479941;5181.248718935771;5634.183043458716;5653.321601407857;5668.461496157858;5672.914906276409;5693.174489699012;6140.723667434976;6147.44672979434;6154.96922515389;6167.290761562388;6180.289266734293;6059.242594675666;6069.605475644069;6083.726232319512;6098;6186.381361863822;5749.798757043525;5760.251167348218;5778.56660750437;5779.104238842986;5787.884242315172;6274.058891166362;6275.152854364694;6278.874422511524;6281;6288.591241569284;5884.882302353929;5915.467607915222;5921.3782552831335;5923.229980102559;6020.307664618625;6071.473041962396;6076.085763601392;6076.817695469143;6104.664243466563;6108.725107370179;6033.788817391458;6036.607620504741;6039.456448919618;6039.486643635252;6044.667543285162;5898.1152827076285;6015.6691381974415;6027.186329845503;6041.697915104227;6125.785597504066;4654.441467023911;4681.180793361148;4685.250359942393;4692.389989301369;4721.220998535203;4134.297169481196;4154.626083652486;4171.228322760238;4177.8537751178565;4212.620864122244;5622.184783206412;5729.197912292282;5810.680412577349;5826;5929;6173.444390004921;6184.81445556634;6195;6206.751729930752;6207.937920620826;5908.438698323653;5911.201987731602;5915.053591425437;5915.112733090071;5948.85127871798;5186.792528298901;5247.396549396792;5270.710110943858;5272.340957380327;5357.383900851452;6376.744930202833;6392.4246817786625;6412.5190610704385;6423;6429.099926010363;6105.9084113737445;6160.630362178284;6161.229846269216;6173.56785025044;6174.073888916699;6067.089936509559;6185.226846644169;6253.437190652863;6310.810675679737;6401.071844582416;6057.545684073624;6078.817635470943;6080.8783824324155;6082.7262773174425;6103.694815259308;6164.137020816999;6211.440970312694;6215.223097112861;6215.782447614311;6216.751329946752;5855.3559108498885;5879.323877754113;5903.144044113666;5915.994280972331;6010;5918.585699001029;5957.76168953237;5958.553108516965;5969.492593129459;5973.940260597338;5862.973979553646;5905.881882362242;5907.4683278505145;5912.674802885883;5920.940790592212;5849.473547380756;6040.697965101639;6101.572889897665;6108.236470441195;6116.357782432959;5937.495312898279;5938.940610593839;5939.287285525765;5939.9308124538;5956.702164891824 03:56:02 INFO - PROCESS | 20871 | |1;ext.html;620.8789286089211;626.3611116661006;670.8289386206519;671.8219671786977;679.755288096285;35386.76146334879;46223;47883;47914.520854791444;47993;48702.51297487024;49142.75428622852;49352.25971610429;49394.50605493944;49416.25875611869;8464.195901389357;9286.814263714721;9413.294002949771;9430.858537121949;9435.575399107056;8352.872362231083;8630.180132887397;8640.697575584856;11009.779804403906;11265.155113366489;11440.71398215043;11509.539618415296;11510.942445287803;11516.136289778258;11516.193866429354;11208.215424920218;11234;11241.494132764044;11252.26860254081;11301.943490282578;11113.888861111367;11165.106791456665;11173.441327933571;11175.888241117565;11190.216684832065;45391.773041134584;45731.771341143416;45769.77115114436;45811.541884581064;45841.312380314324;3859.8456061757497;4049.493813273341;4064.5325787534516;4295.656347492193;4603.401557797499;34683.653163468545;34882.860542551294;34954.30091398183;35051.82474087613;35234;4604.953950460486;4621.237495813187;4643.767811609439;4685.1800934836265;4710.905781884378;404182;610491;620609;624196.9999999955;627814;68214.31785682178;68672.3132768666;68816.65591672009;68820.6558967212;68945;39028.60971390307;39643.20713585712;39932.40101398481;72675;73173.63413183007;19338.516537086405;19469.513262168275;19472.513187170433;19479.415617531497;19488.512787180432;14043.227622480861;15618.9219053904;15707.68584628301;15718.214089295718;15735.68528629421;20256.493587660425;21096.578068438852;21265.68101478479;21963.670544941837;22022.009009594607;7520.811979700442;7545.094588649397;7645;7681.231876812274;7711.344535714527;1062.2670357453333;1075.9677209683723;1118.176604074718;1152.6426807689643;1207.4626791077885;35089.28615729658;36048.27903441969;36070.67673673822;36159.66084069928;40259.79870100631;1190.4940400329824;1210.7941649919535;1224.7121926347302;1226.5768309933237;1270.30133426615;17461.825381746276;18526.814731852777;18678.25286988505;18685.346012889484;18728;683036;686444;687800;688235;688655;62141.68929155325;62148.68925655343;62453.37546624566;62609;62612.37387626065;1356.186288227056;1485.695432436348;1512.7125846089427;1529.4799768078906;1534.088075407706;34357.31285374228;35730.64269357273;36305.81847090748;36674.44988325124;36874.8156259217;58375;60358.39641603528;61922.38077619166;62103.37896620976;62123;578407;581774;585271;586568;590441;29944.850275748482;31387.84306078455;31587.21031974219;33183;33405.66594334025;52556.737216313675;52830.735846320524;52997.4700253008;53097;53416.732916336725;43732.41372416774;48973.26540101973;49225;49759.253611195134;50318.01768148425;44451.77411294353;46530.767346163055;46555.767221163675;46638.30042549432;47519.287210691175;46378.76810615925;46579.53420465752;47182.76408617935;47428.05143897172;47460.28809567928;37335.626643733216;38846.4173037399;39587.54045065339;40305.395419069326;41417.171656567305;30660.540091898194;30796.846015769777;31298.843505782326;31428.37143257168;31925 03:56:02 INFO - PROCESS | 20871 | |2;jquery.html;397.3820708797822;411.362388298138;427.0860358832099;432.161606483422;445.70806121990086;15991.440299589516;20101.497462563442;20365.59268814623;20750.48123796904;20795.16819327225;16837.158142092878;16838.158092095407;16847;16912.83087169128;17063.91468042658;4332.67504937131;5641.351244606872;5855.502282305988;5865.530757539408;6260.280067792194;6493.642849643268;6516.0877477153235;6536.869262614745;6577.572457790228;6618.139641846553;6545.476361891037;7271.309225623558;7589.051368578927;7605.201453847321;7606.163322034572;7265.963670181642;7442.962785186067;7492.812679683025;7570.924290757077;7625.61871906408;7165;7379;7380.114386273682;7389.076365454318;7391.22392148822;27519;27943;28244.15267541977;28541.143765687062;28569.142925712054;2623.5671114266124;2657.906973255927;2751.8073734838567;2820.703826098251;3322.368749937504;16154.919225403915;16254.593635159097;16321.510354689259;16605.66788664232;17050.14749262544;2137.465633591602;2194.484296190394;2205.4045407739823;2243.955120897573;2263.4907145892207;58708.706456467444;90290.09709902882;91848.54075729645;104659.47670261677;108820.91179088187;16701.749473757904;18475.722864157047;18756.624867502574;19031.90484047571;19277.518062048563;35137.47293790595;35281.1179720509;35349.646503534634;35440.291194175974;35573;10909.83635245472;10994.175436842268;11040.392778397265;11099.778004439866;11330.660080197607;9226.492542910204;9236.07639236071;9236.538173091452;9311.394759340621;9486.098820612031;9035.503047332328;9320.135972805467;9407.43555386679;9561.235101191887;9572.377795443273;3622.2755448909797;3629.0784772023776;3669.5779985301497;3681.6318368163506;3756.4928734620476;975.3465178330536;1052.752603138262;1066.402814423925;1096.6490722968574;1115.3363748569589;20281.594368112554;20494.18023279082;20659.58680826375;20788.27241046556;20838.68741968872;1083.7399024234128;1120.1486869978712;1142.2232881640398;1143.1940481960198;1159.211736019498;10661.946690266654;11609.245399049034;11620.709482262842;11653.708657283636;11734.178607497564;544106;548559;552577;566246;567376;57995.710021449624;80907;101030.45362958685;102026.48986755019;102145;1028.7068185567077;1064.2390690656218;1082.783443311341;1122.085500317239;1124.5670416889557;18221.180046897658;18649;18724;18800.34198803035;19136.521586960436;44282.3357649642;46479.30281045719;46918.29622555596;47071.764641176575;47118.76440617775;57122.14316785168;57612.42387576238;60726.08910866429;62731.686341569824;65120.348796513324;8300.501969881827;8357.289630381243;8855.512946787989;8857.822843542965;8866.86699699492;9520;12090.335031573348;12557.518477888538;13093.214407135602;13183.868161318647;10803;11163.72090697739;11597.942010289895;11622.535098595961;11703.414829258674;11174.497147628213;11315;11537.88462115368;11745.588904388305;11896.821547676618;11043.282186657842;11434.599789007345;11474.770504589695;11552.249103808226;11978;8431.662733490837;8737.475751454933;8789.780255493664;8881.200691937756;8924.598393072458;9831.85252221203;10524.15806735444;10855.511501982272;11128.221024528206;11547.8267825981 03:56:02 INFO - PROCESS | 20871 | |3;mootools.html;1399.6430910117917;1547.2031903569664;1610.7503336982766;1773.1843352058052;1890.5840715042693;8386.329093672506;9333.300002499815;9577.61689532418;9625.903740962596;9903.257255705816;9640.80718385632;9725.027497250288;9729.805403891936;9738.561764720587;9744.951275243631;2497.4006238502766;2545.5163518931436;2546.414324705319;2551.3111459905813;2553.0681301324976;2486.676732024834;2562.090457887451;2564.923052308434;2565.4997275531277;2567.52500787354;2485.391079185593;2502.9374265643323;2511.824172307939;2524.684414448194;2529.1148098165586;2496.7628075332905;2512.987435062822;2519.685039370079;2533.67062281904;2535.1760677779794;2406.518696260737;2437.9878100609562;2440.023990403835;2446.376174075617;2448.791852692523;9557.283203759745;9607.087326704022;9652.27607929408;9658.082482164184;9726.465044422554;5728.112142617901;5972.283326000907;5976.910346344808;5984.73068711909;5985.970070149665;3552.6980206682465;3654.7441679082476;3704.111013356775;3763.9435408468894;3774.5281839770028;1130.4630300607228;1148.8621365436118;1153.3253046967534;1159.0981263893295;1168.719507318246;13883.722325553534;13909;13987.300634968211;13990.650233744136;13994.510192143227;4902.4362198346935;4904.828331008398;4924.43369012561;4954.182559877652;5128.3333166688835;10729.570817167227;10750.516226769814;10756.300840445503;10792.568297268179;10799.892001080047;5783.248177736868;5794.21778059965;5801.82594522165;5803.709814509258;5804.6807425592;4570;4604.976975115103;5173.689578625294;5259.526642602184;5438.265834112423;4125.938110928279;4136.648384887319;4153.7507749535125;4157.446391853508;4181.581841815855;1215.1311812054423;1221.3587866370226;1223.7797196504714;1230.3048777440717;1236.2644226685288;1048.3709774135457;1051.4007016000805;1052.936823790575;1061.5647584490475;1065.4140222877386;6399.488040956805;6410.487161027107;6420.5184611154355;6587.53887227899;6677;508.23764353469795;509.8037255656599;511.3046257090354;513.2070950381669;522.636767446621;4206.978965105155;4431.645468362523;4511.278195488771;4522.095580883836;4646.558576935186;12012.939935300443;12315.322657253937;12400.19398739097;12434.316112613713;12450.190737602208;12041.879581204252;12109.031277497956;12259.509619615115;12292.815607765891;12295.446704898122;8982.955085224532;9078.773030674285;9123.270138388913;9163.496007719506;9171.678991235409;6344.365563443619;6388.297287298301;6489.5781774184525;6511.34886511345;6683.83290417724;11186.161037922026;11231.494582743633;11231.943840280746;11241.60654377093;11318.434078296217;10265.2301077418;11058.612948546763;11418;11554.306741595532;11635.243709158878;7819.84360312802;8019.558924259221;8043.115257321807;8047.114817370201;8340;9457.38526995743;9638.277129215197;9754.219662427131;9759.268054895769;9762.951185244028;8199.139090395423;8376.162383761819;8451;8614.095519970313;8617.439866408664;8458.788530286793;8497.150284971452;8500.957495212484;8555.401121921406;8578.399512034348;7897.565633890191;7977.960110199412;7979.202079791974;7981;8028.31759300466;5686.459786320293;5706.543476521952;5827.446392592697;5830.5627077968475;5833.533317334688;5683.772649094155;5798.536117110705;5852.4440178183;5875.118732190205;5988.5508586855285 03:56:02 INFO - PROCESS | 20871 | |4;prototype.html;337.15878882188935;344.1362180925875;350.3763301323644;366.0975694912041;366.9357862374082;5402.540784033357;5503.53219976302;5519.282493275873;5532.944670553294;5537.833864984047;5434.429384914586;5450.509454149126;5452.972735136319;5454.60907468595;5470.7264636768205;3996.5403978542404;4342.3052311630145;4343.587359200887;4344.587264209895;4351.891202719926;3853.3834586466173;4259.957400426003;4263.083437061031;4267.274563324227;4269.679774016946;4229.386738922854;4231.186261136356;4252.574742525753;4263.4031235627035;4268;4081.693857965452;4246.087091275391;4259.318509038554;4262.722923009995;4268.530461649216;3740.4576336431337;3789.5452545694416;3802.8478860845535;3816.1795214029116;3845.0964023454467;5280.630355875091;5300.390455097675;5301.310829592167;5366.114591092504;5394.163904594794;4648.930266046012;4920.458749537548;4944.653874228806;4952.975235123838;4959.107360675077;5640;5654.349749778787;5661.348944871352;5661.7735290588735;5704.429557044304;4080.3471444568727;4106.322456794625;4108;4113.568075352105;4138.482689663792;5540.418256083093;5759.625624334447;5928.140419639129;6006.369331220247;6013.579049466539;4214.894627634334;4227.640650544677;4228.492580890313;4229.281022226229;4232.280512312853;4309.375140604595;4313.827446902152;4322.567743225715;4325.545817689161;4327.870163895088;4746.335513028179;4852.951470485321;4908.730019848871;4912.656114072052;4916.139675556763;5615.522680572197;5654.971725141348;5658.34928983164;5678.545716342683;5760.917908918708;1463.4877792772656;1471.4114354258381;1487.780020383297;1491.9925400372929;1500.6173425776358;927.0034712683891;961.1541843178098;961.8653388525612;972.3776782858976;987.4914419074182;4830.951690483121;4884.218525035977;4884.682495637843;4917.188663870421;4925.655204135676;5101.923471147936;5104.285400043923;5110.7955681773055;5121.334226550524;5141.948580514147;4606.957809030348;4919.581835544019;4925.285833554115;4940.950590494121;4945.8021679132435;2713.9728602714117;2722.5916112583272;2734.5487994480686;2735.5623100303856;2743.9588406173925;5325.920111198335;5326.014687282865;5342.332208473941;5343.465653434703;5351.545118664879;5221.921671174935;5256.713329701592;5573.331200255995;6014.3761184479945;6045.183900173421;6101.96949015261;6126.264848218153;6145.231846019158;6147.877042459126;6160.568760186744;5594.832155035356;5877.529797616266;5888.970555147197;5892.646441213541;5894.882102358015;5802.1296805479515;5808.6224395414165;5814.418558144152;5820.447057529528;5831.650100993954;5836.358000619844;5926.407359264039;6057.515398768;6068.543549548165;6080.270367555921;4248.4477017987465;4250.341197114452;4261.893452663709;4272.889048847384;4295.935560966651;5668.5465162787705;5925.229720136354;5929.954165812787;5933.080372542263;5959.463648271676;5683.318001839806;5700.25896633435;5700.771969121354;5714.599923018887;5716.514096301861;5710.3154569401295;5714.228579141763;5719.714014299351;5735.738137609719;5769.94230057694;5449;5617.241672374341;5667.149927510906;5676.2337084493065;5682.119271512922;5768.1636162757;5778.624389414675;5793.103448275862;5799.623024503394;5802.187693722966;5646.209530665628;5646.689432081275;5651.57613179005;5673.574481913955;5694.373618902 03:56:02 INFO - PROCESS | 20871 | |5;yui.html;767.4589414462804;790.9644066017029;814.6456291513196;822.8560001999653;847.8812966184731;16609.169541522922;16735.246913888874;17451.73822392662;17916.91041544792;17920.910395448038;17858.910705446488;18188.181531831066;18214.453566392996;18235.27058917645;18244.361447349347;750.8798592225245;882.2985726347537;912.2337236721153;917.1607978699482;917.1653795046509;875.8248350329927;903.5211337990876;904.0507467159489;909.8680691299758;910.399136569864;939.1078475448318;945.0313428735533;948.0424770981324;948.2887834124407;948.3740731117464;776.0454640791801;940.8212439636482;940.8682784410188;941.5904081724472;941.8210539997413;679.6024325769431;685.3763075601229;685.5441131647449;685.6194811879404;694.3473135252897;15545.067295962279;15576.61058473536;15583.766243506243;15598.610034749108;15603.297851596706;14838.925805371013;15178.31697573612;15501.457448989344;15665.373385064584;15812;14421.639459013504;14559.78160327596;14587.635309117251;14614.634634134125;14621.342039608244;4796.784144713496;4798.616110711135;4862.805487780484;4923.4091908970795;4933.975330123362;82807.5859620704;87116.56441717815;88679.55660221723;89441.55279223627;89622.55188724014;12470.376481176087;12496.75006499883;12592.622221333375;12638.431270592662;12832.358382081045;23193.652095218586;23330.416739581648;23412;23466.7653323468;23495.295141145794;9188.540572971458;9503.334766566411;9681.854772178423;9764.365316254421;9771.413715177112;5100.260462232955;5241.816536421207;5289.074411977966;5347.866303342447;5364.14173732201;4018.33697439925;4138.875833724993;4146.481689788777;4148.108156746314;4171.395147703566;670.5105273150627;685.3591891581387;687.8968154776724;689.9827504312332;694.7880896326669;766.5592284436472;768.4390395011561;778.7624774443849;787.2560430393338;789.2423273657239;10019.198464122852;10157.567676486282;10365.896341036492;10632.840507392395;10882.183836212316;753.6495529578663;755.720383458113;816.1593558634497;840.4243093480985;851.3529717414809;4810.254410566298;5032.370953630796;5051.595872330205;5093.79502185982;5147.794088236428;76773.61613191899;102262.48868755758;135962.3201884004;135971;141908;99257;113160.43419782848;114857;117175.41412292884;119661;94817;96386.51806740921;99264.5036774826;101362;104808.47595761972;9076.228520575825;9537.666181683608;9659.178969787647;9666.371685840399;9687.515624218902;56593.43406566046;57862.7106864463;58092.70953645205;58184.4181558179;58624.4137558619;82724;89053.55473222851;90401.54799225961;90664.54667726882;92610;13247.470101195844;13667.248301343521;14099.718005640036;14115.717685646436;14288.42846286137;16169.67660646804;16266.674666506367;16992.150392480573;17179.570510737332;17899.642007159524;15321.233938303263;15422.383104676137;15515.689686205988;16586.917065414596;16611.089724681817;15566.766498502759;15624.140672263135;16514.58713532123;16761.497155085366;16769.245383957994;14881.553553393416;15307.61730956735;15360.692786144438;15888.2055897207;16634.417795377103;12584.496620135458;12591.68520786951;12644.747105058032;12863.935680321913;13214.471421143431;12921.676958076123;13322.600321990356;13342.528873496152;13483.595492135251;13697.794533081813 03:56:02 INFO - PROCESS | 20871 | __end_tp_report 03:56:02 INFO - PROCESS | 20871 | __start_cc_report 03:56:02 INFO - PROCESS | 20871 | _x_x_mozilla_cycle_collect,1056 03:56:02 INFO - PROCESS | 20871 | __end_cc_report 03:56:02 INFO - PROCESS | 20871 | __startTimestamp1470912962765__endTimestamp 03:56:02 INFO - PROCESS | 20871 | 03:56:02 INFO - PROCESS | 20871 | ------- Summary: start ------- 03:56:02 INFO - PROCESS | 20871 | Number of tests: 6 03:56:02 INFO - PROCESS | 20871 | 03:56:02 INFO - PROCESS | 20871 | [#0] dojo.html Cycles:165 Average:5681.91 Median:5915.11 stddev:655.09 (11.1%) stddev-sans-first:628.24 03:56:02 INFO - PROCESS | 20871 | Values: 3230.5 3236.1 3247.1 3270.6 3274.1 5613.6 5663.8 5685.9 5687.5 5709.4 5643.5 5688.2 5707.6 5730.7 5743.9 5044.8 5127.6 5144.3 5154.9 5216.3 5205.3 5257.3 5259.4 5260.9 5261.9 5118.6 5121.6 5159.7 5176.6 5244.3 5204.1 5262.6 5273.3 5276.2 5307.0 5105.8 5107.4 5129.2 5176.3 5181.2 5634.2 5653.3 5668.5 5672.9 5693.2 6140.7 6147.4 6155.0 6167.3 6180.3 6059.2 6069.6 6083.7 6098.0 6186.4 5749.8 5760.3 5778.6 5779.1 5787.9 6274.1 6275.2 6278.9 6281.0 6288.6 5884.9 5915.5 5921.4 5923.2 6020.3 6071.5 6076.1 6076.8 6104.7 6108.7 6033.8 6036.6 6039.5 6039.5 6044.7 5898.1 6015.7 6027.2 6041.7 6125.8 4654.4 4681.2 4685.3 4692.4 4721.2 4134.3 4154.6 4171.2 4177.9 4212.6 5622.2 5729.2 5810.7 5826.0 5929.0 6173.4 6184.8 6195.0 6206.8 6207.9 5908.4 5911.2 5915.1 5915.1 5948.9 5186.8 5247.4 5270.7 5272.3 5357.4 6376.7 6392.4 6412.5 6423.0 6429.1 6105.9 6160.6 6161.2 6173.6 6174.1 6067.1 6185.2 6253.4 6310.8 6401.1 6057.5 6078.8 6080.9 6082.7 6103.7 6164.1 6211.4 6215.2 6215.8 6216.8 5855.4 5879.3 5903.1 5916.0 6010.0 5918.6 5957.8 5958.6 5969.5 5973.9 5863.0 5905.9 5907.5 5912.7 5920.9 5849.5 6040.7 6101.6 6108.2 6116.4 5937.5 5938.9 5939.3 5939.9 5956.7 03:56:02 INFO - PROCESS | 20871 | 03:56:02 INFO - PROCESS | 20871 | [#1] ext.html Cycles:180 Average:77414.85 Median:24014.04 stddev:165419.58 (688.8%) stddev-sans-first:165783.14 03:56:02 INFO - PROCESS | 20871 | Values: 620.9 626.4 670.8 671.8 679.8 35386.8 46223.0 47883.0 47914.5 47993.0 48702.5 49142.8 49352.3 49394.5 49416.3 8464.2 9286.8 9413.3 9430.9 9435.6 8352.9 8630.2 8640.7 11009.8 11265.2 11440.7 11509.5 11510.9 11516.1 11516.2 11208.2 11234.0 11241.5 11252.3 11301.9 11113.9 11165.1 11173.4 11175.9 11190.2 45391.8 45731.8 45769.8 45811.5 45841.3 3859.8 4049.5 4064.5 4295.7 4603.4 34683.7 34882.9 34954.3 35051.8 35234.0 4605.0 4621.2 4643.8 4685.2 4710.9 404182.0 610491.0 620609.0 624197.0 627814.0 68214.3 68672.3 68816.7 68820.7 68945.0 39028.6 39643.2 39932.4 72675.0 73173.6 19338.5 19469.5 19472.5 19479.4 19488.5 14043.2 15618.9 15707.7 15718.2 15735.7 20256.5 21096.6 21265.7 21963.7 22022.0 7520.8 7545.1 7645.0 7681.2 7711.3 1062.3 1076.0 1118.2 1152.6 1207.5 35089.3 36048.3 36070.7 36159.7 40259.8 1190.5 1210.8 1224.7 1226.6 1270.3 17461.8 18526.8 18678.3 18685.3 18728.0 683036.0 686444.0 687800.0 688235.0 688655.0 62141.7 62148.7 62453.4 62609.0 62612.4 1356.2 1485.7 1512.7 1529.5 1534.1 34357.3 35730.6 36305.8 36674.4 36874.8 58375.0 60358.4 61922.4 62103.4 62123.0 578407.0 581774.0 585271.0 586568.0 590441.0 29944.9 31387.8 31587.2 33183.0 33405.7 52556.7 52830.7 52997.5 53097.0 53416.7 43732.4 48973.3 49225.0 49759.3 50318.0 44451.8 46530.8 46555.8 46638.3 47519.3 46378.8 46579.5 47182.8 47428.1 47460.3 37335.6 38846.4 39587.5 40305.4 41417.2 30660.5 30796.8 31298.8 31428.4 31925.0 03:56:02 INFO - PROCESS | 20871 | 03:56:02 INFO - PROCESS | 20871 | [#2] jquery.html Cycles:180 Average:32759.55 Median:27731.00 stddev:91319.97 (329.3%) stddev-sans-first:91543.82 03:56:02 INFO - PROCESS | 20871 | Values: 397.4 411.4 427.1 432.2 445.7 15991.4 20101.5 20365.6 20750.5 20795.2 16837.2 16838.2 16847.0 16912.8 17063.9 4332.7 5641.4 5855.5 5865.5 6260.3 6493.6 6516.1 6536.9 6577.6 6618.1 6545.5 7271.3 7589.1 7605.2 7606.2 7266.0 7443.0 7492.8 7570.9 7625.6 7165.0 7379.0 7380.1 7389.1 7391.2 27519.0 27943.0 28244.2 28541.1 28569.1 2623.6 2657.9 2751.8 2820.7 3322.4 16154.9 16254.6 16321.5 16605.7 17050.1 2137.5 2194.5 2205.4 2244.0 2263.5 58708.7 90290.1 91848.5 104659.5 108820.9 16701.7 18475.7 18756.6 19031.9 19277.5 35137.5 35281.1 35349.6 35440.3 35573.0 10909.8 10994.2 11040.4 11099.8 11330.7 9226.5 9236.1 9236.5 9311.4 9486.1 9035.5 9320.1 9407.4 9561.2 9572.4 3622.3 3629.1 3669.6 3681.6 3756.5 975.3 1052.8 1066.4 1096.6 1115.3 20281.6 20494.2 20659.6 20788.3 20838.7 1083.7 1120.1 1142.2 1143.2 1159.2 10661.9 11609.2 11620.7 11653.7 11734.2 544106.0 548559.0 552577.0 566246.0 567376.0 57995.7 80907.0 101030.5 102026.5 102145.0 1028.7 1064.2 1082.8 1122.1 1124.6 18221.2 18649.0 18724.0 18800.3 19136.5 44282.3 46479.3 46918.3 47071.8 47118.8 57122.1 57612.4 60726.1 62731.7 65120.3 8300.5 8357.3 8855.5 8857.8 8866.9 9520.0 12090.3 12557.5 13093.2 13183.9 10803.0 11163.7 11597.9 11622.5 11703.4 11174.5 11315.0 11537.9 11745.6 11896.8 11043.3 11434.6 11474.8 11552.2 11978.0 8431.7 8737.5 8789.8 8881.2 8924.6 9831.9 10524.2 10855.5 11128.2 11547.8 03:56:02 INFO - PROCESS | 20871 | 03:56:02 INFO - PROCESS | 20871 | [#3] mootools.html Cycles:180 Average:6358.72 Median:4625.77 stddev:3705.14 (80.1%) stddev-sans-first:3696.79 03:56:02 INFO - PROCESS | 20871 | Values: 1399.6 1547.2 1610.8 1773.2 1890.6 8386.3 9333.3 9577.6 9625.9 9903.3 9640.8 9725.0 9729.8 9738.6 9745.0 2497.4 2545.5 2546.4 2551.3 2553.1 2486.7 2562.1 2564.9 2565.5 2567.5 2485.4 2502.9 2511.8 2524.7 2529.1 2496.8 2513.0 2519.7 2533.7 2535.2 2406.5 2438.0 2440.0 2446.4 2448.8 9557.3 9607.1 9652.3 9658.1 9726.5 5728.1 5972.3 5976.9 5984.7 5986.0 3552.7 3654.7 3704.1 3763.9 3774.5 1130.5 1148.9 1153.3 1159.1 1168.7 13883.7 13909.0 13987.3 13990.7 13994.5 4902.4 4904.8 4924.4 4954.2 5128.3 10729.6 10750.5 10756.3 10792.6 10799.9 5783.2 5794.2 5801.8 5803.7 5804.7 4570.0 4605.0 5173.7 5259.5 5438.3 4125.9 4136.6 4153.8 4157.4 4181.6 1215.1 1221.4 1223.8 1230.3 1236.3 1048.4 1051.4 1052.9 1061.6 1065.4 6399.5 6410.5 6420.5 6587.5 6677.0 508.2 509.8 511.3 513.2 522.6 4207.0 4431.6 4511.3 4522.1 4646.6 12012.9 12315.3 12400.2 12434.3 12450.2 12041.9 12109.0 12259.5 12292.8 12295.4 8983.0 9078.8 9123.3 9163.5 9171.7 6344.4 6388.3 6489.6 6511.3 6683.8 11186.2 11231.5 11231.9 11241.6 11318.4 10265.2 11058.6 11418.0 11554.3 11635.2 7819.8 8019.6 8043.1 8047.1 8340.0 9457.4 9638.3 9754.2 9759.3 9763.0 8199.1 8376.2 8451.0 8614.1 8617.4 8458.8 8497.2 8501.0 8555.4 8578.4 7897.6 7978.0 7979.2 7981.0 8028.3 5686.5 5706.5 5827.4 5830.6 5833.5 5683.8 5798.5 5852.4 5875.1 5988.6 03:56:02 INFO - PROCESS | 20871 | 03:56:02 INFO - PROCESS | 20871 | [#4] prototype.html Cycles:180 Average:4733.16 Median:5325.97 stddev:1388.22 (26.1%) stddev-sans-first:1352.34 03:56:02 INFO - PROCESS | 20871 | Values: 337.2 344.1 350.4 366.1 366.9 5402.5 5503.5 5519.3 5532.9 5537.8 5434.4 5450.5 5453.0 5454.6 5470.7 3996.5 4342.3 4343.6 4344.6 4351.9 3853.4 4260.0 4263.1 4267.3 4269.7 4229.4 4231.2 4252.6 4263.4 4268.0 4081.7 4246.1 4259.3 4262.7 4268.5 3740.5 3789.5 3802.8 3816.2 3845.1 5280.6 5300.4 5301.3 5366.1 5394.2 4648.9 4920.5 4944.7 4953.0 4959.1 5640.0 5654.3 5661.3 5661.8 5704.4 4080.3 4106.3 4108.0 4113.6 4138.5 5540.4 5759.6 5928.1 6006.4 6013.6 4214.9 4227.6 4228.5 4229.3 4232.3 4309.4 4313.8 4322.6 4325.5 4327.9 4746.3 4853.0 4908.7 4912.7 4916.1 5615.5 5655.0 5658.3 5678.5 5760.9 1463.5 1471.4 1487.8 1492.0 1500.6 927.0 961.2 961.9 972.4 987.5 4831.0 4884.2 4884.7 4917.2 4925.7 5101.9 5104.3 5110.8 5121.3 5141.9 4607.0 4919.6 4925.3 4941.0 4945.8 2714.0 2722.6 2734.5 2735.6 2744.0 5325.9 5326.0 5342.3 5343.5 5351.5 5221.9 5256.7 5573.3 6014.4 6045.2 6102.0 6126.3 6145.2 6147.9 6160.6 5594.8 5877.5 5889.0 5892.6 5894.9 5802.1 5808.6 5814.4 5820.4 5831.7 5836.4 5926.4 6057.5 6068.5 6080.3 4248.4 4250.3 4261.9 4272.9 4295.9 5668.5 5925.2 5930.0 5933.1 5959.5 5683.3 5700.3 5700.8 5714.6 5716.5 5710.3 5714.2 5719.7 5735.7 5769.9 5449.0 5617.2 5667.1 5676.2 5682.1 5768.2 5778.6 5793.1 5799.6 5802.2 5646.2 5646.7 5651.6 5673.6 5694.4 03:56:02 INFO - PROCESS | 20871 | 03:56:02 INFO - PROCESS | 20871 | [#5] yui.html Cycles:180 Average:23419.19 Median:4797.70 stddev:33665.18 (701.7%) stddev-sans-first:33716.66 03:56:02 INFO - PROCESS | 20871 | Values: 767.5 791.0 814.6 822.9 847.9 16609.2 16735.2 17451.7 17916.9 17920.9 17858.9 18188.2 18214.5 18235.3 18244.4 750.9 882.3 912.2 917.2 917.2 875.8 903.5 904.1 909.9 910.4 939.1 945.0 948.0 948.3 948.4 776.0 940.8 940.9 941.6 941.8 679.6 685.4 685.5 685.6 694.3 15545.1 15576.6 15583.8 15598.6 15603.3 14838.9 15178.3 15501.5 15665.4 15812.0 14421.6 14559.8 14587.6 14614.6 14621.3 4796.8 4798.6 4862.8 4923.4 4934.0 82807.6 87116.6 88679.6 89441.6 89622.6 12470.4 12496.8 12592.6 12638.4 12832.4 23193.7 23330.4 23412.0 23466.8 23495.3 9188.5 9503.3 9681.9 9764.4 9771.4 5100.3 5241.8 5289.1 5347.9 5364.1 4018.3 4138.9 4146.5 4148.1 4171.4 670.5 685.4 687.9 690.0 694.8 766.6 768.4 778.8 787.3 789.2 10019.2 10157.6 10365.9 10632.8 10882.2 753.6 755.7 816.2 840.4 851.4 4810.3 5032.4 5051.6 5093.8 5147.8 76773.6 102262.5 135962.3 135971.0 141908.0 99257.0 113160.4 114857.0 117175.4 119661.0 94817.0 96386.5 99264.5 101362.0 104808.5 9076.2 9537.7 9659.2 9666.4 9687.5 56593.4 57862.7 58092.7 58184.4 58624.4 82724.0 89053.6 90401.5 90664.5 92610.0 13247.5 13667.2 14099.7 14115.7 14288.4 16169.7 16266.7 16992.2 17179.6 17899.6 15321.2 15422.4 15515.7 16586.9 16611.1 15566.8 15624.1 16514.6 16761.5 16769.2 14881.6 15307.6 15360.7 15888.2 16634.4 12584.5 12591.7 12644.7 12863.9 13214.5 12921.7 13322.6 13342.5 13483.6 13697.8 03:56:02 INFO - PROCESS | 20871 | -------- Summary: end -------- 03:56:02 INFO - PROCESS | 20871 | 03:56:03 INFO - TEST-INFO | 20871: exit 0 03:56:03 INFO - TEST-OK | dromaeo_css | took 1113876ms 03:56:03 INFO - TEST-START | kraken 03:56:03 INFO - operating with platform_type : linux_ 03:56:03 INFO - Initialising browser for kraken test... 03:56:03 INFO - TEST-INFO | started process 21073 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUNSTF_/profile http://localhost:47637/getInfo.html) 03:56:07 INFO - PROCESS | 21073 | __metrics Screen width/height:1600/1200 03:56:07 INFO - PROCESS | 21073 | colorDepth:24 03:56:07 INFO - PROCESS | 21073 | Browser inner width/height: 1024/697 03:56:07 INFO - PROCESS | 21073 | __metrics 03:56:08 INFO - PROCESS | 21073 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:56:08 INFO - PROCESS | 21073 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:56:09 INFO - TEST-INFO | 21073: exit 0 03:56:09 INFO - Browser initialized. 03:56:09 INFO - Running cycle 1/1 for kraken test... 03:56:09 INFO - TEST-INFO | started process 21164 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUNSTF_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:56:20 INFO - PROCESS | 21164 | RSS: Main: 144941056 03:56:20 INFO - PROCESS | 21164 | 03:56:23 INFO - PROCESS | 21164 | Cycle 1(1): loaded http://localhost:47637/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47637/tests/kraken/driver.html?testName=audio-beat-detection) 03:56:24 INFO - PROCESS | 21164 | RSS: Main: 191737856 03:56:24 INFO - PROCESS | 21164 | 03:56:26 INFO - PROCESS | 21164 | Cycle 1(1): loaded http://localhost:47637/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47637/tests/kraken/driver.html?testName=audio-dft) 03:56:27 INFO - PROCESS | 21164 | RSS: Main: 181018624 03:56:27 INFO - PROCESS | 21164 | 03:56:30 INFO - PROCESS | 21164 | Cycle 1(1): loaded http://localhost:47637/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47637/tests/kraken/driver.html?testName=audio-fft) 03:56:30 INFO - PROCESS | 21164 | RSS: Main: 269246464 03:56:30 INFO - PROCESS | 21164 | 03:56:32 INFO - PROCESS | 21164 | Cycle 1(1): loaded http://localhost:47637/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47637/tests/kraken/driver.html?testName=audio-oscillator) 03:56:33 INFO - PROCESS | 21164 | RSS: Main: 175206400 03:56:33 INFO - PROCESS | 21164 | 03:56:35 INFO - PROCESS | 21164 | Cycle 1(1): loaded http://localhost:47637/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47637/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:56:36 INFO - PROCESS | 21164 | RSS: Main: 176930816 03:56:36 INFO - PROCESS | 21164 | 03:56:39 INFO - PROCESS | 21164 | Cycle 1(1): loaded http://localhost:47637/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47637/tests/kraken/driver.html?testName=imaging-darkroom) 03:56:39 INFO - PROCESS | 21164 | RSS: Main: 213200896 03:56:39 INFO - PROCESS | 21164 | 03:56:43 INFO - PROCESS | 21164 | Cycle 1(1): loaded http://localhost:47637/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47637/tests/kraken/driver.html?testName=imaging-desaturate) 03:56:43 INFO - PROCESS | 21164 | RSS: Main: 212082688 03:56:43 INFO - PROCESS | 21164 | 03:56:46 INFO - PROCESS | 21164 | Cycle 1(1): loaded http://localhost:47637/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47637/tests/kraken/driver.html?testName=json-parse-financial) 03:56:47 INFO - PROCESS | 21164 | RSS: Main: 212111360 03:56:47 INFO - PROCESS | 21164 | 03:56:48 INFO - PROCESS | 21164 | Cycle 1(1): loaded http://localhost:47637/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47637/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:56:49 INFO - PROCESS | 21164 | RSS: Main: 176009216 03:56:49 INFO - PROCESS | 21164 | 03:56:50 INFO - PROCESS | 21164 | Cycle 1(1): loaded http://localhost:47637/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47637/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:56:51 INFO - PROCESS | 21164 | RSS: Main: 181927936 03:56:51 INFO - PROCESS | 21164 | 03:56:53 INFO - PROCESS | 21164 | Cycle 1(1): loaded http://localhost:47637/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47637/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:56:54 INFO - PROCESS | 21164 | RSS: Main: 186994688 03:56:54 INFO - PROCESS | 21164 | 03:56:56 INFO - PROCESS | 21164 | Cycle 1(1): loaded http://localhost:47637/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47637/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:56:57 INFO - PROCESS | 21164 | RSS: Main: 181342208 03:56:57 INFO - PROCESS | 21164 | 03:56:59 INFO - PROCESS | 21164 | Cycle 1(1): loaded http://localhost:47637/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47637/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:57:00 INFO - PROCESS | 21164 | RSS: Main: 184516608 03:57:00 INFO - PROCESS | 21164 | 03:57:02 INFO - PROCESS | 21164 | Cycle 1(1): loaded http://localhost:47637/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47637/tests/kraken/driver.html?testName=ai-astar) 03:57:02 INFO - PROCESS | 21164 | RSS: Main: 236949504 03:57:02 INFO - PROCESS | 21164 | 03:57:02 INFO - PROCESS | 21164 | __start_tp_report 03:57:02 INFO - PROCESS | 21164 | _x_x_mozilla_page_load 03:57:02 INFO - PROCESS | 21164 | _x_x_mozilla_page_load_details 03:57:02 INFO - PROCESS | 21164 | |i|pagename|runs| 03:57:02 INFO - PROCESS | 21164 | |0;ai-astar;101;111;109;111;112;111;109;110;111;111 03:57:02 INFO - PROCESS | 21164 | |1;audio-beat-detection;141;116;115;174;116;118;144;115;150;119 03:57:02 INFO - PROCESS | 21164 | |2;audio-dft;161;162;161;161;162;160;161;161;161;160 03:57:02 INFO - PROCESS | 21164 | |3;audio-fft;75;75;75;118;76;77;75;75;104;74 03:57:02 INFO - PROCESS | 21164 | |4;audio-oscillator;83;84;117;84;84;84;119;83;83;132 03:57:02 INFO - PROCESS | 21164 | |5;imaging-gaussian-blur;117;117;116;117;117;117;117;116;117;116 03:57:02 INFO - PROCESS | 21164 | |6;imaging-darkroom;146;145;146;145;146;145;145;145;146;145 03:57:02 INFO - PROCESS | 21164 | |7;imaging-desaturate;95;94;96;94;94;94;94;94;95;95 03:57:02 INFO - PROCESS | 21164 | |8;json-parse-financial;51;52;54;51;51;53;51;52;50;51 03:57:02 INFO - PROCESS | 21164 | |9;json-stringify-tinderbox;61;63;61;61;60;62;61;61;61;60 03:57:02 INFO - PROCESS | 21164 | |10;stanford-crypto-aes;72;72;72;71;81;77;71;72;71;77 03:57:02 INFO - PROCESS | 21164 | |11;stanford-crypto-ccm;128;118;117;116;118;123;130;117;159;121 03:57:02 INFO - PROCESS | 21164 | |12;stanford-crypto-pbkdf2;150;156;151;153;150;151;151;152;151;151 03:57:02 INFO - PROCESS | 21164 | |13;stanford-crypto-sha256-iterative;63;61;63;62;61;63;62;64;60;60 03:57:02 INFO - PROCESS | 21164 | __end_tp_report 03:57:02 INFO - PROCESS | 21164 | __start_cc_report 03:57:02 INFO - PROCESS | 21164 | _x_x_mozilla_cycle_collect,1650 03:57:02 INFO - PROCESS | 21164 | __end_cc_report 03:57:02 INFO - PROCESS | 21164 | __startTimestamp1470913022374__endTimestamp 03:57:02 INFO - PROCESS | 21164 | 03:57:02 INFO - PROCESS | 21164 | ------- Summary: start ------- 03:57:02 INFO - PROCESS | 21164 | Number of tests: 14 03:57:02 INFO - PROCESS | 21164 | 03:57:02 INFO - PROCESS | 21164 | [#0] ai-astar Cycles:10 Average:109.60 Median:111.00 stddev:3.17 (2.9%) stddev-sans-first:1.01 03:57:02 INFO - PROCESS | 21164 | Values: 101.0 111.0 109.0 111.0 112.0 111.0 109.0 110.0 111.0 111.0 03:57:02 INFO - PROCESS | 21164 | 03:57:02 INFO - PROCESS | 21164 | [#1] audio-beat-detection Cycles:10 Average:130.80 Median:130.00 stddev:20.42 (15.7%) stddev-sans-first:21.32 03:57:02 INFO - PROCESS | 21164 | Values: 141.0 116.0 115.0 174.0 116.0 118.0 144.0 115.0 150.0 119.0 03:57:02 INFO - PROCESS | 21164 | 03:57:02 INFO - PROCESS | 21164 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:0.67 (0.4%) stddev-sans-first:0.71 03:57:02 INFO - PROCESS | 21164 | Values: 161.0 162.0 161.0 161.0 162.0 160.0 161.0 161.0 161.0 160.0 03:57:02 INFO - PROCESS | 21164 | 03:57:02 INFO - PROCESS | 21164 | [#3] audio-fft Cycles:10 Average:82.40 Median:75.00 stddev:15.45 (20.6%) stddev-sans-first:16.15 03:57:02 INFO - PROCESS | 21164 | Values: 75.0 75.0 75.0 118.0 76.0 77.0 75.0 75.0 104.0 74.0 03:57:02 INFO - PROCESS | 21164 | 03:57:02 INFO - PROCESS | 21164 | [#4] audio-oscillator Cycles:10 Average:95.30 Median:83.50 stddev:19.28 (23.1%) stddev-sans-first:19.92 03:57:02 INFO - PROCESS | 21164 | Values: 83.0 84.0 117.0 84.0 84.0 84.0 119.0 83.0 83.0 132.0 03:57:02 INFO - PROCESS | 21164 | 03:57:02 INFO - PROCESS | 21164 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 03:57:02 INFO - PROCESS | 21164 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 117.0 116.0 117.0 116.0 03:57:02 INFO - PROCESS | 21164 | 03:57:02 INFO - PROCESS | 21164 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 03:57:02 INFO - PROCESS | 21164 | Values: 146.0 145.0 146.0 145.0 146.0 145.0 145.0 145.0 146.0 145.0 03:57:02 INFO - PROCESS | 21164 | 03:57:02 INFO - PROCESS | 21164 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:94.50 stddev:0.71 (0.7%) stddev-sans-first:0.73 03:57:02 INFO - PROCESS | 21164 | Values: 95.0 94.0 96.0 94.0 94.0 94.0 94.0 94.0 95.0 95.0 03:57:02 INFO - PROCESS | 21164 | 03:57:02 INFO - PROCESS | 21164 | [#8] json-parse-financial Cycles:10 Average:51.60 Median:51.50 stddev:1.17 (2.3%) stddev-sans-first:1.22 03:57:02 INFO - PROCESS | 21164 | Values: 51.0 52.0 54.0 51.0 51.0 53.0 51.0 52.0 50.0 51.0 03:57:02 INFO - PROCESS | 21164 | 03:57:02 INFO - PROCESS | 21164 | [#9] json-stringify-tinderbox Cycles:10 Average:61.10 Median:61.00 stddev:0.88 (1.4%) stddev-sans-first:0.93 03:57:02 INFO - PROCESS | 21164 | Values: 61.0 63.0 61.0 61.0 60.0 62.0 61.0 61.0 61.0 60.0 03:57:02 INFO - PROCESS | 21164 | 03:57:02 INFO - PROCESS | 21164 | [#10] stanford-crypto-aes Cycles:10 Average:73.60 Median:72.00 stddev:3.47 (4.8%) stddev-sans-first:3.63 03:57:02 INFO - PROCESS | 21164 | Values: 72.0 72.0 72.0 71.0 81.0 77.0 71.0 72.0 71.0 77.0 03:57:02 INFO - PROCESS | 21164 | 03:57:02 INFO - PROCESS | 21164 | [#11] stanford-crypto-ccm Cycles:10 Average:124.70 Median:122.00 stddev:12.98 (10.6%) stddev-sans-first:13.71 03:57:02 INFO - PROCESS | 21164 | Values: 128.0 118.0 117.0 116.0 118.0 123.0 130.0 117.0 159.0 121.0 03:57:02 INFO - PROCESS | 21164 | 03:57:02 INFO - PROCESS | 21164 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.60 Median:151.00 stddev:1.78 (1.2%) stddev-sans-first:1.79 03:57:02 INFO - PROCESS | 21164 | Values: 150.0 156.0 151.0 153.0 150.0 151.0 151.0 152.0 151.0 151.0 03:57:02 INFO - PROCESS | 21164 | 03:57:02 INFO - PROCESS | 21164 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.90 Median:62.50 stddev:1.37 (2.2%) stddev-sans-first:1.39 03:57:02 INFO - PROCESS | 21164 | Values: 63.0 61.0 63.0 62.0 61.0 63.0 62.0 64.0 60.0 60.0 03:57:02 INFO - PROCESS | 21164 | -------- Summary: end -------- 03:57:02 INFO - PROCESS | 21164 | 03:57:03 INFO - TEST-INFO | 21164: exit 0 03:57:03 INFO - TEST-OK | kraken | took 59899ms 03:57:03 INFO - SUITE-END | took 1173s 03:57:03 INFO - Completed test suite (00:19:33) 03:57:03 INFO - javascript benchmark 03:57:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3230.45082336003, 3236.1262459136033, 3247.107045562471, 3270.640229574745, 3274.0505253476476, 5613.550915926721, 5663.773449062043, 5685.8578535536635, 5687.459691329323, 5709.371969083408, 5643.463870932265, 5688.232088668028, 5707.571932105088, 5730.68481233532, 5743.942560574393, 5044.82343117991, 5127.615428842833, 5144.305518754976, 5154.948450515484, 5216.3218781558535, 5205.349331333583, 5257.263983042377, 5259.447757985414, 5260.8684782880355, 5261.921071183935, 5118.6416950813455, 5121.641485096045, 5159.71621560814, 5176.55999240065, 5244.292020577231, 5204.063268611649, 5262.578993680516, 5273.314469119028, 5276.234945932818, 5306.973465132688, 5105.795768169269, 5107.412647545542, 5129.230615407681, 5176.327077479941, 5181.248718935771, 5634.183043458716, 5653.321601407857, 5668.461496157858, 5672.914906276409, 5693.174489699012, 6140.723667434976, 6147.44672979434, 6154.96922515389, 6167.290761562388, 6180.289266734293, 6059.242594675666, 6069.605475644069, 6083.726232319512, 6098.0, 6186.381361863822, 5749.798757043525, 5760.251167348218, 5778.56660750437, 5779.104238842986, 5787.884242315172, 6274.058891166362, 6275.152854364694, 6278.874422511524, 6281.0, 6288.591241569284, 5884.882302353929, 5915.467607915222, 5921.3782552831335, 5923.229980102559, 6020.307664618625, 6071.473041962396, 6076.085763601392, 6076.817695469143, 6104.664243466563, 6108.725107370179, 6033.788817391458, 6036.607620504741, 6039.456448919618, 6039.486643635252, 6044.667543285162, 5898.1152827076285, 6015.6691381974415, 6027.186329845503, 6041.697915104227, 6125.785597504066, 4654.441467023911, 4681.180793361148, 4685.250359942393, 4692.389989301369, 4721.220998535203, 4134.297169481196, 4154.626083652486, 4171.228322760238, 4177.8537751178565, 4212.620864122244, 5622.184783206412, 5729.197912292282, 5810.680412577349, 5826.0, 5929.0, 6173.444390004921, 6184.81445556634, 6195.0, 6206.751729930752, 6207.937920620826, 5908.438698323653, 5911.201987731602, 5915.053591425437, 5915.112733090071, 5948.85127871798, 5186.792528298901, 5247.396549396792, 5270.710110943858, 5272.340957380327, 5357.383900851452, 6376.744930202833, 6392.4246817786625, 6412.5190610704385, 6423.0, 6429.099926010363, 6105.9084113737445, 6160.630362178284, 6161.229846269216, 6173.56785025044, 6174.073888916699, 6067.089936509559, 6185.226846644169, 6253.437190652863, 6310.810675679737, 6401.071844582416, 6057.545684073624, 6078.817635470943, 6080.8783824324155, 6082.7262773174425, 6103.694815259308, 6164.137020816999, 6211.440970312694, 6215.223097112861, 6215.782447614311, 6216.751329946752, 5855.3559108498885, 5879.323877754113, 5903.144044113666, 5915.994280972331, 6010.0, 5918.585699001029, 5957.76168953237, 5958.553108516965, 5969.492593129459, 5973.940260597338, 5862.973979553646, 5905.881882362242, 5907.4683278505145, 5912.674802885883, 5920.940790592212, 5849.473547380756, 6040.697965101639, 6101.572889897665, 6108.236470441195, 6116.357782432959, 5937.495312898279, 5938.940610593839, 5939.287285525765, 5939.9308124538, 5956.702164891824], "value": 5636.591350871564, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [620.8789286089211, 626.3611116661006, 670.8289386206519, 671.8219671786977, 679.755288096285, 35386.76146334879, 46223.0, 47883.0, 47914.520854791444, 47993.0, 48702.51297487024, 49142.75428622852, 49352.25971610429, 49394.50605493944, 49416.25875611869, 8464.195901389357, 9286.814263714721, 9413.294002949771, 9430.858537121949, 9435.575399107056, 8352.872362231083, 8630.180132887397, 8640.697575584856, 11009.779804403906, 11265.155113366489, 11440.71398215043, 11509.539618415296, 11510.942445287803, 11516.136289778258, 11516.193866429354, 11208.215424920218, 11234.0, 11241.494132764044, 11252.26860254081, 11301.943490282578, 11113.888861111367, 11165.106791456665, 11173.441327933571, 11175.888241117565, 11190.216684832065, 45391.773041134584, 45731.771341143416, 45769.77115114436, 45811.541884581064, 45841.312380314324, 3859.8456061757497, 4049.493813273341, 4064.5325787534516, 4295.656347492193, 4603.401557797499, 34683.653163468545, 34882.860542551294, 34954.30091398183, 35051.82474087613, 35234.0, 4604.953950460486, 4621.237495813187, 4643.767811609439, 4685.1800934836265, 4710.905781884378, 404182.0, 610491.0, 620609.0, 624196.9999999955, 627814.0, 68214.31785682178, 68672.3132768666, 68816.65591672009, 68820.6558967212, 68945.0, 39028.60971390307, 39643.20713585712, 39932.40101398481, 72675.0, 73173.63413183007, 19338.516537086405, 19469.513262168275, 19472.513187170433, 19479.415617531497, 19488.512787180432, 14043.227622480861, 15618.9219053904, 15707.68584628301, 15718.214089295718, 15735.68528629421, 20256.493587660425, 21096.578068438852, 21265.68101478479, 21963.670544941837, 22022.009009594607, 7520.811979700442, 7545.094588649397, 7645.0, 7681.231876812274, 7711.344535714527, 1062.2670357453333, 1075.9677209683723, 1118.176604074718, 1152.6426807689643, 1207.4626791077885, 35089.28615729658, 36048.27903441969, 36070.67673673822, 36159.66084069928, 40259.79870100631, 1190.4940400329824, 1210.7941649919535, 1224.7121926347302, 1226.5768309933237, 1270.30133426615, 17461.825381746276, 18526.814731852777, 18678.25286988505, 18685.346012889484, 18728.0, 683036.0, 686444.0, 687800.0, 688235.0, 688655.0, 62141.68929155325, 62148.68925655343, 62453.37546624566, 62609.0, 62612.37387626065, 1356.186288227056, 1485.695432436348, 1512.7125846089427, 1529.4799768078906, 1534.088075407706, 34357.31285374228, 35730.64269357273, 36305.81847090748, 36674.44988325124, 36874.8156259217, 58375.0, 60358.39641603528, 61922.38077619166, 62103.37896620976, 62123.0, 578407.0, 581774.0, 585271.0, 586568.0, 590441.0, 29944.850275748482, 31387.84306078455, 31587.21031974219, 33183.0, 33405.66594334025, 52556.737216313675, 52830.735846320524, 52997.4700253008, 53097.0, 53416.732916336725, 43732.41372416774, 48973.26540101973, 49225.0, 49759.253611195134, 50318.01768148425, 44451.77411294353, 46530.767346163055, 46555.767221163675, 46638.30042549432, 47519.287210691175, 46378.76810615925, 46579.53420465752, 47182.76408617935, 47428.05143897172, 47460.28809567928, 37335.626643733216, 38846.4173037399, 39587.54045065339, 40305.395419069326, 41417.171656567305, 30660.540091898194, 30796.846015769777, 31298.843505782326, 31428.37143257168, 31925.0], "value": 22952.9529346456, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [397.3820708797822, 411.362388298138, 427.0860358832099, 432.161606483422, 445.70806121990086, 15991.440299589516, 20101.497462563442, 20365.59268814623, 20750.48123796904, 20795.16819327225, 16837.158142092878, 16838.158092095407, 16847.0, 16912.83087169128, 17063.91468042658, 4332.67504937131, 5641.351244606872, 5855.502282305988, 5865.530757539408, 6260.280067792194, 6493.642849643268, 6516.0877477153235, 6536.869262614745, 6577.572457790228, 6618.139641846553, 6545.476361891037, 7271.309225623558, 7589.051368578927, 7605.201453847321, 7606.163322034572, 7265.963670181642, 7442.962785186067, 7492.812679683025, 7570.924290757077, 7625.61871906408, 7165.0, 7379.0, 7380.114386273682, 7389.076365454318, 7391.22392148822, 27519.0, 27943.0, 28244.15267541977, 28541.143765687062, 28569.142925712054, 2623.5671114266124, 2657.906973255927, 2751.8073734838567, 2820.703826098251, 3322.368749937504, 16154.919225403915, 16254.593635159097, 16321.510354689259, 16605.66788664232, 17050.14749262544, 2137.465633591602, 2194.484296190394, 2205.4045407739823, 2243.955120897573, 2263.4907145892207, 58708.706456467444, 90290.09709902882, 91848.54075729645, 104659.47670261677, 108820.91179088187, 16701.749473757904, 18475.722864157047, 18756.624867502574, 19031.90484047571, 19277.518062048563, 35137.47293790595, 35281.1179720509, 35349.646503534634, 35440.291194175974, 35573.0, 10909.83635245472, 10994.175436842268, 11040.392778397265, 11099.778004439866, 11330.660080197607, 9226.492542910204, 9236.07639236071, 9236.538173091452, 9311.394759340621, 9486.098820612031, 9035.503047332328, 9320.135972805467, 9407.43555386679, 9561.235101191887, 9572.377795443273, 3622.2755448909797, 3629.0784772023776, 3669.5779985301497, 3681.6318368163506, 3756.4928734620476, 975.3465178330536, 1052.752603138262, 1066.402814423925, 1096.6490722968574, 1115.3363748569589, 20281.594368112554, 20494.18023279082, 20659.58680826375, 20788.27241046556, 20838.68741968872, 1083.7399024234128, 1120.1486869978712, 1142.2232881640398, 1143.1940481960198, 1159.211736019498, 10661.946690266654, 11609.245399049034, 11620.709482262842, 11653.708657283636, 11734.178607497564, 544106.0, 548559.0, 552577.0, 566246.0, 567376.0, 57995.710021449624, 80907.0, 101030.45362958685, 102026.48986755019, 102145.0, 1028.7068185567077, 1064.2390690656218, 1082.783443311341, 1122.085500317239, 1124.5670416889557, 18221.180046897658, 18649.0, 18724.0, 18800.34198803035, 19136.521586960436, 44282.3357649642, 46479.30281045719, 46918.29622555596, 47071.764641176575, 47118.76440617775, 57122.14316785168, 57612.42387576238, 60726.08910866429, 62731.686341569824, 65120.348796513324, 8300.501969881827, 8357.289630381243, 8855.512946787989, 8857.822843542965, 8866.86699699492, 9520.0, 12090.335031573348, 12557.518477888538, 13093.214407135602, 13183.868161318647, 10803.0, 11163.72090697739, 11597.942010289895, 11622.535098595961, 11703.414829258674, 11174.497147628213, 11315.0, 11537.88462115368, 11745.588904388305, 11896.821547676618, 11043.282186657842, 11434.599789007345, 11474.770504589695, 11552.249103808226, 11978.0, 8431.662733490837, 8737.475751454933, 8789.780255493664, 8881.200691937756, 8924.598393072458, 9831.85252221203, 10524.15806735444, 10855.511501982272, 11128.221024528206, 11547.8267825981], "value": 10781.746865617533, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1399.6430910117917, 1547.2031903569664, 1610.7503336982766, 1773.1843352058052, 1890.5840715042693, 8386.329093672506, 9333.300002499815, 9577.61689532418, 9625.903740962596, 9903.257255705816, 9640.80718385632, 9725.027497250288, 9729.805403891936, 9738.561764720587, 9744.951275243631, 2497.4006238502766, 2545.5163518931436, 2546.414324705319, 2551.3111459905813, 2553.0681301324976, 2486.676732024834, 2562.090457887451, 2564.923052308434, 2565.4997275531277, 2567.52500787354, 2485.391079185593, 2502.9374265643323, 2511.824172307939, 2524.684414448194, 2529.1148098165586, 2496.7628075332905, 2512.987435062822, 2519.685039370079, 2533.67062281904, 2535.1760677779794, 2406.518696260737, 2437.9878100609562, 2440.023990403835, 2446.376174075617, 2448.791852692523, 9557.283203759745, 9607.087326704022, 9652.27607929408, 9658.082482164184, 9726.465044422554, 5728.112142617901, 5972.283326000907, 5976.910346344808, 5984.73068711909, 5985.970070149665, 3552.6980206682465, 3654.7441679082476, 3704.111013356775, 3763.9435408468894, 3774.5281839770028, 1130.4630300607228, 1148.8621365436118, 1153.3253046967534, 1159.0981263893295, 1168.719507318246, 13883.722325553534, 13909.0, 13987.300634968211, 13990.650233744136, 13994.510192143227, 4902.4362198346935, 4904.828331008398, 4924.43369012561, 4954.182559877652, 5128.3333166688835, 10729.570817167227, 10750.516226769814, 10756.300840445503, 10792.568297268179, 10799.892001080047, 5783.248177736868, 5794.21778059965, 5801.82594522165, 5803.709814509258, 5804.6807425592, 4570.0, 4604.976975115103, 5173.689578625294, 5259.526642602184, 5438.265834112423, 4125.938110928279, 4136.648384887319, 4153.7507749535125, 4157.446391853508, 4181.581841815855, 1215.1311812054423, 1221.3587866370226, 1223.7797196504714, 1230.3048777440717, 1236.2644226685288, 1048.3709774135457, 1051.4007016000805, 1052.936823790575, 1061.5647584490475, 1065.4140222877386, 6399.488040956805, 6410.487161027107, 6420.5184611154355, 6587.53887227899, 6677.0, 508.23764353469795, 509.8037255656599, 511.3046257090354, 513.2070950381669, 522.636767446621, 4206.978965105155, 4431.645468362523, 4511.278195488771, 4522.095580883836, 4646.558576935186, 12012.939935300443, 12315.322657253937, 12400.19398739097, 12434.316112613713, 12450.190737602208, 12041.879581204252, 12109.031277497956, 12259.509619615115, 12292.815607765891, 12295.446704898122, 8982.955085224532, 9078.773030674285, 9123.270138388913, 9163.496007719506, 9171.678991235409, 6344.365563443619, 6388.297287298301, 6489.5781774184525, 6511.34886511345, 6683.83290417724, 11186.161037922026, 11231.494582743633, 11231.943840280746, 11241.60654377093, 11318.434078296217, 10265.2301077418, 11058.612948546763, 11418.0, 11554.306741595532, 11635.243709158878, 7819.84360312802, 8019.558924259221, 8043.115257321807, 8047.114817370201, 8340.0, 9457.38526995743, 9638.277129215197, 9754.219662427131, 9759.268054895769, 9762.951185244028, 8199.139090395423, 8376.162383761819, 8451.0, 8614.095519970313, 8617.439866408664, 8458.788530286793, 8497.150284971452, 8500.957495212484, 8555.401121921406, 8578.399512034348, 7897.565633890191, 7977.960110199412, 7979.202079791974, 7981.0, 8028.31759300466, 5686.459786320293, 5706.543476521952, 5827.446392592697, 5830.5627077968475, 5833.533317334688, 5683.772649094155, 5798.536117110705, 5852.4440178183, 5875.118732190205, 5988.5508586855285], "value": 4956.235278302125, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [337.15878882188935, 344.1362180925875, 350.3763301323644, 366.0975694912041, 366.9357862374082, 5402.540784033357, 5503.53219976302, 5519.282493275873, 5532.944670553294, 5537.833864984047, 5434.429384914586, 5450.509454149126, 5452.972735136319, 5454.60907468595, 5470.7264636768205, 3996.5403978542404, 4342.3052311630145, 4343.587359200887, 4344.587264209895, 4351.891202719926, 3853.3834586466173, 4259.957400426003, 4263.083437061031, 4267.274563324227, 4269.679774016946, 4229.386738922854, 4231.186261136356, 4252.574742525753, 4263.4031235627035, 4268.0, 4081.693857965452, 4246.087091275391, 4259.318509038554, 4262.722923009995, 4268.530461649216, 3740.4576336431337, 3789.5452545694416, 3802.8478860845535, 3816.1795214029116, 3845.0964023454467, 5280.630355875091, 5300.390455097675, 5301.310829592167, 5366.114591092504, 5394.163904594794, 4648.930266046012, 4920.458749537548, 4944.653874228806, 4952.975235123838, 4959.107360675077, 5640.0, 5654.349749778787, 5661.348944871352, 5661.7735290588735, 5704.429557044304, 4080.3471444568727, 4106.322456794625, 4108.0, 4113.568075352105, 4138.482689663792, 5540.418256083093, 5759.625624334447, 5928.140419639129, 6006.369331220247, 6013.579049466539, 4214.894627634334, 4227.640650544677, 4228.492580890313, 4229.281022226229, 4232.280512312853, 4309.375140604595, 4313.827446902152, 4322.567743225715, 4325.545817689161, 4327.870163895088, 4746.335513028179, 4852.951470485321, 4908.730019848871, 4912.656114072052, 4916.139675556763, 5615.522680572197, 5654.971725141348, 5658.34928983164, 5678.545716342683, 5760.917908918708, 1463.4877792772656, 1471.4114354258381, 1487.780020383297, 1491.9925400372929, 1500.6173425776358, 927.0034712683891, 961.1541843178098, 961.8653388525612, 972.3776782858976, 987.4914419074182, 4830.951690483121, 4884.218525035977, 4884.682495637843, 4917.188663870421, 4925.655204135676, 5101.923471147936, 5104.285400043923, 5110.7955681773055, 5121.334226550524, 5141.948580514147, 4606.957809030348, 4919.581835544019, 4925.285833554115, 4940.950590494121, 4945.8021679132435, 2713.9728602714117, 2722.5916112583272, 2734.5487994480686, 2735.5623100303856, 2743.9588406173925, 5325.920111198335, 5326.014687282865, 5342.332208473941, 5343.465653434703, 5351.545118664879, 5221.921671174935, 5256.713329701592, 5573.331200255995, 6014.3761184479945, 6045.183900173421, 6101.96949015261, 6126.264848218153, 6145.231846019158, 6147.877042459126, 6160.568760186744, 5594.832155035356, 5877.529797616266, 5888.970555147197, 5892.646441213541, 5894.882102358015, 5802.1296805479515, 5808.6224395414165, 5814.418558144152, 5820.447057529528, 5831.650100993954, 5836.358000619844, 5926.407359264039, 6057.515398768, 6068.543549548165, 6080.270367555921, 4248.4477017987465, 4250.341197114452, 4261.893452663709, 4272.889048847384, 4295.935560966651, 5668.5465162787705, 5925.229720136354, 5929.954165812787, 5933.080372542263, 5959.463648271676, 5683.318001839806, 5700.25896633435, 5700.771969121354, 5714.599923018887, 5716.514096301861, 5710.3154569401295, 5714.228579141763, 5719.714014299351, 5735.738137609719, 5769.94230057694, 5449.0, 5617.241672374341, 5667.149927510906, 5676.2337084493065, 5682.119271512922, 5768.1636162757, 5778.624389414675, 5793.103448275862, 5799.623024503394, 5802.187693722966, 5646.209530665628, 5646.689432081275, 5651.57613179005, 5673.574481913955, 5694.373618902], "value": 4296.52748501205, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [767.4589414462804, 790.9644066017029, 814.6456291513196, 822.8560001999653, 847.8812966184731, 16609.169541522922, 16735.246913888874, 17451.73822392662, 17916.91041544792, 17920.910395448038, 17858.910705446488, 18188.181531831066, 18214.453566392996, 18235.27058917645, 18244.361447349347, 750.8798592225245, 882.2985726347537, 912.2337236721153, 917.1607978699482, 917.1653795046509, 875.8248350329927, 903.5211337990876, 904.0507467159489, 909.8680691299758, 910.399136569864, 939.1078475448318, 945.0313428735533, 948.0424770981324, 948.2887834124407, 948.3740731117464, 776.0454640791801, 940.8212439636482, 940.8682784410188, 941.5904081724472, 941.8210539997413, 679.6024325769431, 685.3763075601229, 685.5441131647449, 685.6194811879404, 694.3473135252897, 15545.067295962279, 15576.61058473536, 15583.766243506243, 15598.610034749108, 15603.297851596706, 14838.925805371013, 15178.31697573612, 15501.457448989344, 15665.373385064584, 15812.0, 14421.639459013504, 14559.78160327596, 14587.635309117251, 14614.634634134125, 14621.342039608244, 4796.784144713496, 4798.616110711135, 4862.805487780484, 4923.4091908970795, 4933.975330123362, 82807.5859620704, 87116.56441717815, 88679.55660221723, 89441.55279223627, 89622.55188724014, 12470.376481176087, 12496.75006499883, 12592.622221333375, 12638.431270592662, 12832.358382081045, 23193.652095218586, 23330.416739581648, 23412.0, 23466.7653323468, 23495.295141145794, 9188.540572971458, 9503.334766566411, 9681.854772178423, 9764.365316254421, 9771.413715177112, 5100.260462232955, 5241.816536421207, 5289.074411977966, 5347.866303342447, 5364.14173732201, 4018.33697439925, 4138.875833724993, 4146.481689788777, 4148.108156746314, 4171.395147703566, 670.5105273150627, 685.3591891581387, 687.8968154776724, 689.9827504312332, 694.7880896326669, 766.5592284436472, 768.4390395011561, 778.7624774443849, 787.2560430393338, 789.2423273657239, 10019.198464122852, 10157.567676486282, 10365.896341036492, 10632.840507392395, 10882.183836212316, 753.6495529578663, 755.720383458113, 816.1593558634497, 840.4243093480985, 851.3529717414809, 4810.254410566298, 5032.370953630796, 5051.595872330205, 5093.79502185982, 5147.794088236428, 76773.61613191899, 102262.48868755758, 135962.3201884004, 135971.0, 141908.0, 99257.0, 113160.43419782848, 114857.0, 117175.41412292884, 119661.0, 94817.0, 96386.51806740921, 99264.5036774826, 101362.0, 104808.47595761972, 9076.228520575825, 9537.666181683608, 9659.178969787647, 9666.371685840399, 9687.515624218902, 56593.43406566046, 57862.7106864463, 58092.70953645205, 58184.4181558179, 58624.4137558619, 82724.0, 89053.55473222851, 90401.54799225961, 90664.54667726882, 92610.0, 13247.470101195844, 13667.248301343521, 14099.718005640036, 14115.717685646436, 14288.42846286137, 16169.67660646804, 16266.674666506367, 16992.150392480573, 17179.570510737332, 17899.642007159524, 15321.233938303263, 15422.383104676137, 15515.689686205988, 16586.917065414596, 16611.089724681817, 15566.766498502759, 15624.140672263135, 16514.58713532123, 16761.497155085366, 16769.245383957994, 14881.553553393416, 15307.61730956735, 15360.692786144438, 15888.2055897207, 16634.417795377103, 12584.496620135458, 12591.68520786951, 12644.747105058032, 12863.935680321913, 13214.471421143431, 12921.676958076123, 13322.600321990356, 13342.528873496152, 13483.595492135251, 13697.794533081813], "value": 8473.717670645408, "unit": "score"}], "name": "dromaeo_css", "value": 7946.1361562505945, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 111.0, 109.0, 111.0, 112.0, 111.0, 109.0, 110.0, 111.0, 111.0], "value": 109.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 116.0, 115.0, 174.0, 116.0, 118.0, 144.0, 115.0, 150.0, 119.0], "value": 130.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 161.0, 161.0, 162.0, 160.0, 161.0, 161.0, 161.0, 160.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 118.0, 76.0, 77.0, 75.0, 75.0, 104.0, 74.0], "value": 82.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 117.0, 84.0, 84.0, 84.0, 119.0, 83.0, 83.0, 132.0], "value": 95.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 145.0, 146.0, 145.0, 145.0, 145.0, 146.0, 145.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 96.0, 94.0, 94.0, 94.0, 94.0, 94.0, 95.0, 95.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 52.0, 54.0, 51.0, 51.0, 53.0, 51.0, 52.0, 50.0, 51.0], "value": 51.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 63.0, 61.0, 61.0, 60.0, 62.0, 61.0, 61.0, 61.0, 60.0], "value": 61.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 72.0, 72.0, 71.0, 81.0, 77.0, 71.0, 72.0, 71.0, 77.0], "value": 73.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 118.0, 117.0, 116.0, 118.0, 123.0, 130.0, 117.0, 159.0, 121.0], "value": 124.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 156.0, 151.0, 153.0, 150.0, 151.0, 151.0, 152.0, 151.0, 151.0], "value": 151.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 61.0, 63.0, 62.0, 61.0, 63.0, 62.0, 64.0, 60.0, 60.0], "value": 61.9, "unit": "score"}], "name": "kraken", "value": 1460.1999999999998, "alertThreshold": 2.0}]} 03:57:03 INFO - Return code: 0 03:57:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:57:03 INFO - # TBPL SUCCESS # 03:57:03 INFO - Running post-action listener: _resource_record_post_action 03:57:03 INFO - [mozharness: 2016-08-11 10:57:03.690625Z] Finished run-tests step (success) 03:57:03 INFO - Running post-run listener: _resource_record_post_run 03:57:03 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 266240; Write bytes: 328826880; Read time: 32; Write time: 294612 03:57:03 INFO - TinderboxPrint: CPU usage
12.9% 03:57:03 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 32 03:57:03 INFO - TinderboxPrint: I/O write bytes / time
328,826,880 / 294,612 03:57:03 INFO - TinderboxPrint: CPU idle
8,273.9 (87.0%) 03:57:03 INFO - TinderboxPrint: CPU user
1,184.9 (12.5%) 03:57:03 INFO - TinderboxPrint: Swap in / out
0 / 0 03:57:03 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 78303232; Read time: 0; Write time: 101448 03:57:03 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 266240; Write bytes: 249626624; Read time: 32; Write time: 193140 03:57:04 INFO - Running post-run listener: _upload_blobber_files 03:57:04 INFO - Blob upload gear active. 03:57:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:57:04 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 03:57:04 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'] 03:57:04 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 03:57:04 INFO - (blobuploader) - INFO - Open directory for files ... 03:57:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:57:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:57:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:57:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:57:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:57:05 INFO - (blobuploader) - INFO - Done attempting. 03:57:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:57:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:57:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:57:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:57:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:57:06 INFO - (blobuploader) - INFO - Done attempting. 03:57:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:57:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:57:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:57:11 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:57:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:57:11 INFO - (blobuploader) - INFO - Done attempting. 03:57:11 INFO - (blobuploader) - INFO - Iteration through files over. 03:57:11 INFO - Return code: 0 03:57:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:57:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:57:11 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c5c930702834bcc8423b1006df032ef7a507272820444516555f6bea12eeb61bf6fb0648b4ee81811fe11f279690f09677d8d613d7ca0101f809e5f8aedcf669", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e11484a18fb1273790708167aec96c8a073243e0145cf351611ef04b2f321f5ee4907aa24e208a9ab44464f914dec67db3ff233b96f91d5aad9a8d6d33b3bacd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9b21e14010c99823609f69b8ed37329db201677264aba4d8964c82522b69886d3c87d195c7c22732dead1b64028437f2229f68bcf6c2631c3624b2fab562a77a"} 03:57:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:57:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:57:11 INFO - Contents: 03:57:11 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c5c930702834bcc8423b1006df032ef7a507272820444516555f6bea12eeb61bf6fb0648b4ee81811fe11f279690f09677d8d613d7ca0101f809e5f8aedcf669", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e11484a18fb1273790708167aec96c8a073243e0145cf351611ef04b2f321f5ee4907aa24e208a9ab44464f914dec67db3ff233b96f91d5aad9a8d6d33b3bacd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9b21e14010c99823609f69b8ed37329db201677264aba4d8964c82522b69886d3c87d195c7c22732dead1b64028437f2229f68bcf6c2631c3624b2fab562a77a"} 03:57:11 INFO - Running post-run listener: copy_logs_to_upload_dir 03:57:11 INFO - Copying logs to upload dir... 03:57:11 INFO - mkdir: /builds/slave/test/build/upload/logs 03:57:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1680.483544 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 28 mins, 0 secs) (at 2016-08-11 03:57:11.845581) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-11 03:57:11.849794) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1470911349.86671-69503502 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c5c930702834bcc8423b1006df032ef7a507272820444516555f6bea12eeb61bf6fb0648b4ee81811fe11f279690f09677d8d613d7ca0101f809e5f8aedcf669", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e11484a18fb1273790708167aec96c8a073243e0145cf351611ef04b2f321f5ee4907aa24e208a9ab44464f914dec67db3ff233b96f91d5aad9a8d6d33b3bacd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9b21e14010c99823609f69b8ed37329db201677264aba4d8964c82522b69886d3c87d195c7c22732dead1b64028437f2229f68bcf6c2631c3624b2fab562a77a"} build_url:https://queue.taskcluster.net/v1/task/RIeDQBE4S_-4aBTCVQ7SHg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011240 build_url: 'https://queue.taskcluster.net/v1/task/RIeDQBE4S_-4aBTCVQ7SHg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c5c930702834bcc8423b1006df032ef7a507272820444516555f6bea12eeb61bf6fb0648b4ee81811fe11f279690f09677d8d613d7ca0101f809e5f8aedcf669", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e11484a18fb1273790708167aec96c8a073243e0145cf351611ef04b2f321f5ee4907aa24e208a9ab44464f914dec67db3ff233b96f91d5aad9a8d6d33b3bacd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9b21e14010c99823609f69b8ed37329db201677264aba4d8964c82522b69886d3c87d195c7c22732dead1b64028437f2229f68bcf6c2631c3624b2fab562a77a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-11 03:57:11.875064) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 03:57:11.875433) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1470911349.86671-69503502 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004514 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 03:57:11.961120) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-11 03:57:11.961470) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-11 03:57:11.961820) ========= ========= Total master_lag: 0.16 =========