builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-026 starttime: 1472826830.92 results: success (0) buildid: 20160902045242 builduid: c3f11ed22e584033828a7735f25bcd96 revision: b16b9d1eea136bba9d512610e79700192be4e646 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-02 07:33:50.919342) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-02 07:33:50.920116) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-02 07:33:50.920626) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-02 07:33:50.945772) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 07:33:50.946291) ========= 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=41bf3e9aed84707956354da8000001c5-1472826568.862178-660793286 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-02 07:33:51-- 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% 95.4M=0s 2016-09-02 07:33:51 (95.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.294302 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 07:33:51.258974) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 07:33:51.259321) ========= 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=41bf3e9aed84707956354da8000001c5-1472826568.862178-660793286 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016267 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 07:33:51.310892) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 07:33:51.311288) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev b16b9d1eea136bba9d512610e79700192be4e646 --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 b16b9d1eea136bba9d512610e79700192be4e646 --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=41bf3e9aed84707956354da8000001c5-1472826568.862178-660793286 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-02 07:33:51,744 truncating revision to first 12 chars 2016-09-02 07:33:51,744 Setting DEBUG logging. 2016-09-02 07:33:51,744 attempt 1/10 2016-09-02 07:33:51,744 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/b16b9d1eea13?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-02 07:33:52,086 unpacking tar archive at: mozilla-aurora-b16b9d1eea13/testing/mozharness/ program finished with exit code 0 elapsedTime=0.671064 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 07:33:51.997500) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-02 07:33:51.997859) ========= script_repo_revision: b16b9d1eea136bba9d512610e79700192be4e646 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-02 07:33:51.998317) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-02 07:33:51.998603) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-02 07:33:52.009625) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 28 mins, 1 secs) (at 2016-09-02 07:33:52.009947) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41bf3e9aed84707956354da8000001c5-1472826568.862178-660793286 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:33:52 INFO - MultiFileLogger online at 20160902 07:33:52 in /builds/slave/test 07:33:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 07:33:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:33:52 INFO - {'append_to_log': False, 07:33:52 INFO - 'base_work_dir': '/builds/slave/test', 07:33:52 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 07:33:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:33:52 INFO - 'branch': 'Mozilla-Aurora', 07:33:52 INFO - 'buildbot_json_path': 'buildprops.json', 07:33:52 INFO - 'config_files': ('talos/linux_config.py',), 07:33:52 INFO - 'default_actions': ('clobber', 07:33:52 INFO - 'read-buildbot-config', 07:33:52 INFO - 'download-and-extract', 07:33:52 INFO - 'populate-webroot', 07:33:52 INFO - 'create-virtualenv', 07:33:52 INFO - 'install', 07:33:52 INFO - 'run-tests'), 07:33:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:33:52 INFO - 'download_minidump_stackwalk': True, 07:33:52 INFO - 'download_symbols': 'ondemand', 07:33:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:33:52 INFO - 'tooltool.py': '/tools/tooltool.py', 07:33:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:33:52 INFO - '/tools/misc-python/virtualenv.py')}, 07:33:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:33:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:33:52 INFO - 'installer_path': 'installer.exe', 07:33:52 INFO - 'log_level': 'info', 07:33:52 INFO - 'log_name': 'talos', 07:33:52 INFO - 'log_to_console': True, 07:33:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:33:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:33:52 INFO - 'opt_config_files': (), 07:33:52 INFO - 'pip_index': False, 07:33:52 INFO - 'sps_profile': False, 07:33:52 INFO - 'sps_profile_interval': 0, 07:33:52 INFO - 'suite': 'dromaeojs-e10s', 07:33:52 INFO - 'system_bits': '32', 07:33:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:33:52 INFO - 'title': 'talos-linux64-ix-026', 07:33:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:33:52 INFO - 'use_talos_json': True, 07:33:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:33:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:33:52 INFO - 'work_dir': 'build'} 07:33:52 INFO - [mozharness: 2016-09-02 14:33:52.531264Z] Running clobber step. 07:33:52 INFO - Running pre-action listener: _resource_record_pre_action 07:33:52 INFO - Running main action method: clobber 07:33:52 INFO - rmtree: /builds/slave/test/build 07:33:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:33:52 INFO - Running post-action listener: _resource_record_post_action 07:33:52 INFO - [mozharness: 2016-09-02 14:33:52.994753Z] Finished clobber step (success) 07:33:52 INFO - [mozharness: 2016-09-02 14:33:52.994876Z] Running read-buildbot-config step. 07:33:52 INFO - Running pre-action listener: _resource_record_pre_action 07:33:52 INFO - Running main action method: read_buildbot_config 07:33:52 INFO - Using buildbot properties: 07:33:52 INFO - { 07:33:52 INFO - "project": "", 07:33:52 INFO - "product": "firefox", 07:33:52 INFO - "script_repo_revision": "production", 07:33:52 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 07:33:52 INFO - "repository": "", 07:33:52 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 07:33:52 INFO - "buildid": "20160902045242", 07:33:52 INFO - "pgo_build": "True", 07:33:52 INFO - "basedir": "/builds/slave/test", 07:33:52 INFO - "buildnumber": 535, 07:33:52 INFO - "slavename": "talos-linux64-ix-026", 07:33:52 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 07:33:52 INFO - "platform": "ubuntu64_hw", 07:33:52 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 07:33:52 INFO - "branch": "mozilla-aurora", 07:33:52 INFO - "repo_path": "releases/mozilla-aurora", 07:33:52 INFO - "revision": "b16b9d1eea136bba9d512610e79700192be4e646", 07:33:52 INFO - "stage_platform": "linux64-pgo", 07:33:52 INFO - "builduid": "c3f11ed22e584033828a7735f25bcd96", 07:33:52 INFO - "slavebuilddir": "test" 07:33:52 INFO - } 07:33:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZRc_JytXSZepOmvw-0WyWg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2. 07:33:52 INFO - Running post-action listener: _resource_record_post_action 07:33:52 INFO - [mozharness: 2016-09-02 14:33:52.997314Z] Finished read-buildbot-config step (success) 07:33:52 INFO - [mozharness: 2016-09-02 14:33:52.997402Z] Running download-and-extract step. 07:33:52 INFO - Running pre-action listener: _resource_record_pre_action 07:33:52 INFO - Running main action method: download_and_extract 07:33:52 INFO - mkdir: /builds/slave/test/build/tests 07:33:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:33:52 INFO - https://queue.taskcluster.net/v1/task/ZRc_JytXSZepOmvw-0WyWg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:33:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRc_JytXSZepOmvw-0WyWg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 07:33:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRc_JytXSZepOmvw-0WyWg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 07:33:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRc_JytXSZepOmvw-0WyWg/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 07:33:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRc_JytXSZepOmvw-0WyWg/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 07:33:53 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRc_JytXSZepOmvw-0WyWg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 07:33:53 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 07:33:53 INFO - retry: Failed, sleeping 30 seconds before retrying 07:34:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRc_JytXSZepOmvw-0WyWg/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 07:34:23 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRc_JytXSZepOmvw-0WyWg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 07:34:23 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 07:34:23 INFO - retry: Failed, sleeping 60 seconds before retrying 07:35:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRc_JytXSZepOmvw-0WyWg/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 07:35:23 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRc_JytXSZepOmvw-0WyWg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 07:35:23 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 07:35:23 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRc_JytXSZepOmvw-0WyWg/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! 07:35:23 INFO - Caught exception: HTTP Error 404: Not Found 07:35:23 INFO - Caught exception: HTTP Error 404: Not Found 07:35:23 INFO - Caught exception: HTTP Error 404: Not Found 07:35:23 INFO - trying https://queue.taskcluster.net/v1/task/ZRc_JytXSZepOmvw-0WyWg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 07:35:23 INFO - Downloading https://queue.taskcluster.net/v1/task/ZRc_JytXSZepOmvw-0WyWg/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 07:35:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZRc_JytXSZepOmvw-0WyWg/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 07:35:23 INFO - Downloaded 1361 bytes. 07:35:23 INFO - Reading from file /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 07:35:23 INFO - Using the following test package requirements: 07:35:23 INFO - {u'common': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 07:35:23 INFO - u'cppunittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 07:35:23 INFO - u'firefox-50.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 07:35:23 INFO - u'gtest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 07:35:23 INFO - u'firefox-50.0a2.en-US.linux-x86_64.gtest.tests.zip'], 07:35:23 INFO - u'jittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 07:35:23 INFO - u'jsshell-linux-x86_64.zip'], 07:35:23 INFO - u'mochitest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 07:35:23 INFO - u'firefox-50.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 07:35:23 INFO - u'mozbase': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 07:35:23 INFO - u'reftest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 07:35:23 INFO - u'firefox-50.0a2.en-US.linux-x86_64.reftest.tests.zip'], 07:35:23 INFO - u'talos': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 07:35:23 INFO - u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'], 07:35:23 INFO - u'web-platform': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 07:35:23 INFO - u'firefox-50.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 07:35:23 INFO - u'xpcshell': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 07:35:23 INFO - u'firefox-50.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 07:35:23 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:35:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:35:23 INFO - https://queue.taskcluster.net/v1/task/ZRc_JytXSZepOmvw-0WyWg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:35:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRc_JytXSZepOmvw-0WyWg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 07:35:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRc_JytXSZepOmvw-0WyWg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 07:35:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRc_JytXSZepOmvw-0WyWg/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 07:35:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRc_JytXSZepOmvw-0WyWg/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 07:35:23 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRc_JytXSZepOmvw-0WyWg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 07:35:23 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 07:35:23 INFO - retry: Failed, sleeping 30 seconds before retrying 07:35:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRc_JytXSZepOmvw-0WyWg/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 07:35:53 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRc_JytXSZepOmvw-0WyWg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 07:35:53 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 07:35:53 INFO - retry: Failed, sleeping 60 seconds before retrying 07:36:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRc_JytXSZepOmvw-0WyWg/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 07:36:53 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRc_JytXSZepOmvw-0WyWg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 07:36:53 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 07:36:53 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRc_JytXSZepOmvw-0WyWg/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! 07:36:53 INFO - Caught exception: HTTP Error 404: Not Found 07:36:53 INFO - Caught exception: HTTP Error 404: Not Found 07:36:53 INFO - Caught exception: HTTP Error 404: Not Found 07:36:53 INFO - trying https://queue.taskcluster.net/v1/task/ZRc_JytXSZepOmvw-0WyWg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 07:36:53 INFO - Downloading https://queue.taskcluster.net/v1/task/ZRc_JytXSZepOmvw-0WyWg/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 07:36:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZRc_JytXSZepOmvw-0WyWg/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 07:36:54 INFO - Downloaded 21838825 bytes. 07:36:54 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'] 07:36:54 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 07:36:55 INFO - Return code: 0 07:36:55 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 07:36:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:36:55 INFO - https://queue.taskcluster.net/v1/task/ZRc_JytXSZepOmvw-0WyWg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:36:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRc_JytXSZepOmvw-0WyWg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 07:36:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRc_JytXSZepOmvw-0WyWg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 07:36:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRc_JytXSZepOmvw-0WyWg/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 07:36:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRc_JytXSZepOmvw-0WyWg/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 07:36:55 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRc_JytXSZepOmvw-0WyWg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 07:36:55 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 07:36:55 INFO - retry: Failed, sleeping 30 seconds before retrying 07:37:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRc_JytXSZepOmvw-0WyWg/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 07:37:25 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRc_JytXSZepOmvw-0WyWg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 07:37:25 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 07:37:25 INFO - retry: Failed, sleeping 60 seconds before retrying 07:38:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRc_JytXSZepOmvw-0WyWg/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 07:38:25 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRc_JytXSZepOmvw-0WyWg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 07:38:25 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 07:38:25 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRc_JytXSZepOmvw-0WyWg/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! 07:38:25 INFO - Caught exception: HTTP Error 404: Not Found 07:38:25 INFO - Caught exception: HTTP Error 404: Not Found 07:38:25 INFO - Caught exception: HTTP Error 404: Not Found 07:38:25 INFO - trying https://queue.taskcluster.net/v1/task/ZRc_JytXSZepOmvw-0WyWg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 07:38:25 INFO - Downloading https://queue.taskcluster.net/v1/task/ZRc_JytXSZepOmvw-0WyWg/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 07:38:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZRc_JytXSZepOmvw-0WyWg/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 07:38:26 INFO - Downloaded 21838825 bytes. 07:38:26 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'] 07:38:26 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 07:38:28 INFO - Return code: 0 07:38:28 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')]} 07:38:28 INFO - https://queue.taskcluster.net/v1/task/ZRc_JytXSZepOmvw-0WyWg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:38:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRc_JytXSZepOmvw-0WyWg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 07:38:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRc_JytXSZepOmvw-0WyWg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 07:38:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRc_JytXSZepOmvw-0WyWg/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 07:38:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRc_JytXSZepOmvw-0WyWg/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 07:38:28 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRc_JytXSZepOmvw-0WyWg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 07:38:28 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 07:38:28 INFO - retry: Failed, sleeping 30 seconds before retrying 07:38:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRc_JytXSZepOmvw-0WyWg/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 07:38:58 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRc_JytXSZepOmvw-0WyWg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 07:38:58 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 07:38:58 INFO - retry: Failed, sleeping 60 seconds before retrying 07:39:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRc_JytXSZepOmvw-0WyWg/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 07:39:58 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRc_JytXSZepOmvw-0WyWg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 07:39:58 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 07:39:58 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRc_JytXSZepOmvw-0WyWg/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! 07:39:58 INFO - Caught exception: HTTP Error 404: Not Found 07:39:58 INFO - Caught exception: HTTP Error 404: Not Found 07:39:58 INFO - Caught exception: HTTP Error 404: Not Found 07:39:58 INFO - trying https://queue.taskcluster.net/v1/task/ZRc_JytXSZepOmvw-0WyWg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 07:39:58 INFO - Downloading https://queue.taskcluster.net/v1/task/ZRc_JytXSZepOmvw-0WyWg/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 07:39:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZRc_JytXSZepOmvw-0WyWg/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 07:39:59 INFO - Downloaded 14413740 bytes. 07:39:59 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'] 07:39:59 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 07:39:59 INFO - Return code: 0 07:39:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:39:59 INFO - https://queue.taskcluster.net/v1/task/ZRc_JytXSZepOmvw-0WyWg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:39:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRc_JytXSZepOmvw-0WyWg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 07:39:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRc_JytXSZepOmvw-0WyWg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 07:39:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRc_JytXSZepOmvw-0WyWg/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 07:39:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRc_JytXSZepOmvw-0WyWg/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 07:39:59 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRc_JytXSZepOmvw-0WyWg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 07:39:59 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 07:39:59 INFO - retry: Failed, sleeping 30 seconds before retrying 07:40:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRc_JytXSZepOmvw-0WyWg/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 07:40:29 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRc_JytXSZepOmvw-0WyWg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 07:40:29 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 07:40:29 INFO - retry: Failed, sleeping 60 seconds before retrying 07:41:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRc_JytXSZepOmvw-0WyWg/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 07:41:29 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRc_JytXSZepOmvw-0WyWg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 07:41:29 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 07:41:29 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRc_JytXSZepOmvw-0WyWg/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! 07:41:29 INFO - Caught exception: HTTP Error 404: Not Found 07:41:29 INFO - Caught exception: HTTP Error 404: Not Found 07:41:29 INFO - Caught exception: HTTP Error 404: Not Found 07:41:29 INFO - trying https://queue.taskcluster.net/v1/task/ZRc_JytXSZepOmvw-0WyWg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 07:41:29 INFO - Downloading https://queue.taskcluster.net/v1/task/ZRc_JytXSZepOmvw-0WyWg/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 07:41:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZRc_JytXSZepOmvw-0WyWg/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 07:41:31 INFO - Downloaded 63885755 bytes. 07:41:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZRc_JytXSZepOmvw-0WyWg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 07:41:31 INFO - mkdir: /builds/slave/test/properties 07:41:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:41:31 INFO - Writing to file /builds/slave/test/properties/build_url 07:41:31 INFO - Contents: 07:41:31 INFO - build_url:https://queue.taskcluster.net/v1/task/ZRc_JytXSZepOmvw-0WyWg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 07:41:31 INFO - Running post-action listener: _resource_record_post_action 07:41:31 INFO - Running post-action listener: set_extra_try_arguments 07:41:31 INFO - [mozharness: 2016-09-02 14:41:31.902136Z] Finished download-and-extract step (success) 07:41:31 INFO - [mozharness: 2016-09-02 14:41:31.902371Z] Running populate-webroot step. 07:41:31 INFO - Running pre-action listener: _resource_record_pre_action 07:41:31 INFO - Running main action method: populate_webroot 07:41:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:41:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:41:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:41:31 INFO - '--tppagecycles', 07:41:31 INFO - '7'], 07:41:31 INFO - 'tests': ['tsvgm']}}, 07:41:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:41:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:41:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:41:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:41:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:41:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:41:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:41:31 INFO - 'talos_options': ['--disable-e10s'], 07:41:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:41:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:41:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:41:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:41:31 INFO - 'talos_options': ['--disable-e10s'], 07:41:31 INFO - 'tests': ['damp', 'tps']}, 07:41:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:41:31 INFO - 'tests': ['damp', 'tps']}, 07:41:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:41:31 INFO - 'tests': ['dromaeo_dom']}, 07:41:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:41:31 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:41:31 INFO - 'tests': ['basic_compositor_video']}, 07:41:31 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:41:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:41:31 INFO - 'tests': ['a11yr', 07:41:31 INFO - 'ts_paint', 07:41:31 INFO - 'tpaint', 07:41:31 INFO - 'sessionrestore', 07:41:31 INFO - 'sessionrestore_no_auto_restore', 07:41:31 INFO - 'tabpaint']}, 07:41:31 INFO - 'other-e10s': {'tests': ['a11yr', 07:41:31 INFO - 'ts_paint', 07:41:31 INFO - 'tpaint', 07:41:31 INFO - 'sessionrestore', 07:41:31 INFO - 'sessionrestore_no_auto_restore', 07:41:31 INFO - 'tabpaint']}, 07:41:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:41:31 INFO - 'ts_paint', 07:41:31 INFO - 'tpaint', 07:41:31 INFO - 'sessionrestore', 07:41:31 INFO - 'sessionrestore_no_auto_restore', 07:41:31 INFO - 'tabpaint']}, 07:41:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:41:31 INFO - 'ts_paint', 07:41:31 INFO - 'tpaint', 07:41:31 INFO - 'sessionrestore', 07:41:31 INFO - 'sessionrestore_no_auto_restore', 07:41:31 INFO - 'tabpaint']}, 07:41:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:41:31 INFO - 'tests': ['a11yr', 07:41:31 INFO - 'ts_paint', 07:41:31 INFO - 'tpaint', 07:41:31 INFO - 'sessionrestore', 07:41:31 INFO - 'sessionrestore_no_auto_restore', 07:41:31 INFO - 'tabpaint']}, 07:41:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:41:31 INFO - 'tests': ['a11yr', 07:41:31 INFO - 'ts_paint', 07:41:31 INFO - 'tpaint', 07:41:31 INFO - 'sessionrestore', 07:41:31 INFO - 'sessionrestore_no_auto_restore', 07:41:31 INFO - 'tabpaint']}, 07:41:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:41:31 INFO - 'tests': ['tsvgx', 07:41:31 INFO - 'tsvgr_opacity', 07:41:31 INFO - 'tart', 07:41:31 INFO - 'tscrollx', 07:41:31 INFO - 'cart']}, 07:41:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:41:31 INFO - 'tsvgr_opacity', 07:41:31 INFO - 'tart', 07:41:31 INFO - 'tscrollx', 07:41:31 INFO - 'cart']}, 07:41:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:41:31 INFO - 'talos_options': ['--disable-e10s'], 07:41:31 INFO - 'tests': ['tp5o']}, 07:41:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:41:31 INFO - 'tests': ['tp5o']}, 07:41:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:41:31 INFO - 'talos_options': ['--disable-e10s', 07:41:31 INFO - '--xperf_path', 07:41:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:41:31 INFO - 'tests': ['tp5n']}, 07:41:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:41:31 INFO - 'talos_options': ['--xperf_path', 07:41:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:41:31 INFO - 'tests': ['tp5n']}}, 07:41:31 INFO - 'talos.zip': {'path': '', 07:41:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:41:31 INFO - Running post-action listener: _resource_record_post_action 07:41:31 INFO - [mozharness: 2016-09-02 14:41:31.921113Z] Finished populate-webroot step (success) 07:41:31 INFO - [mozharness: 2016-09-02 14:41:31.921202Z] Running create-virtualenv step. 07:41:31 INFO - Running pre-action listener: _resource_record_pre_action 07:41:31 INFO - Running main action method: create_virtualenv 07:41:31 INFO - Creating virtualenv /builds/slave/test/build/venv 07:41:31 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 07:41:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:41:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:41:32 INFO - Using real prefix '/usr' 07:41:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:41:32 INFO - Installing distribute.............................................................................................................................................................................................done. 07:41:34 INFO - Installing pip.................done. 07:41:34 INFO - Return code: 0 07:41:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:41:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:41:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:41:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:41:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:41:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2203030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2432400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c1570>, '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 0x24c2470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24c2900>, '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': '41bf3e9aed84707956354da8000001c5-1472826568.862178-660793286', '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 07:41:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:41:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:41:34 INFO - Using env: {'DISPLAY': ':0', 07:41:34 INFO - 'HOME': '/home/cltbld', 07:41:34 INFO - 'LANG': 'en_US.UTF-8', 07:41:34 INFO - 'LANGUAGE': 'en_US:en', 07:41:34 INFO - 'LOGNAME': 'cltbld', 07:41:34 INFO - 'MAIL': '/var/mail/cltbld', 07:41:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:41:34 INFO - 'MOZ_NO_REMOTE': '1', 07:41:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:41:34 INFO - 'NO_EM_RESTART': '1', 07:41:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:41:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:41:34 INFO - 'PWD': '/builds/slave/test', 07:41:34 INFO - 'SHELL': '/bin/bash', 07:41:34 INFO - 'SHLVL': '1', 07:41:34 INFO - 'TERM': 'linux', 07:41:34 INFO - 'TMOUT': '86400', 07:41:34 INFO - 'USER': 'cltbld', 07:41:34 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1472826568.862178-660793286', 07:41:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:41:34 INFO - '_': '/tools/buildbot/bin/python'} 07:41:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:41:34 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 07:41:34 INFO - Cleaning up... 07:41:34 INFO - Return code: 0 07:41:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:41:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:41:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:41:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:41:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:41:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x2203030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2432400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c1570>, '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 0x24c2470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24c2900>, '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': '41bf3e9aed84707956354da8000001c5-1472826568.862178-660793286', '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 07:41:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:41:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:41:34 INFO - Using env: {'DISPLAY': ':0', 07:41:34 INFO - 'HOME': '/home/cltbld', 07:41:34 INFO - 'LANG': 'en_US.UTF-8', 07:41:34 INFO - 'LANGUAGE': 'en_US:en', 07:41:34 INFO - 'LOGNAME': 'cltbld', 07:41:34 INFO - 'MAIL': '/var/mail/cltbld', 07:41:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:41:34 INFO - 'MOZ_NO_REMOTE': '1', 07:41:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:41:34 INFO - 'NO_EM_RESTART': '1', 07:41:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:41:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:41:34 INFO - 'PWD': '/builds/slave/test', 07:41:34 INFO - 'SHELL': '/bin/bash', 07:41:34 INFO - 'SHLVL': '1', 07:41:34 INFO - 'TERM': 'linux', 07:41:34 INFO - 'TMOUT': '86400', 07:41:34 INFO - 'USER': 'cltbld', 07:41:34 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1472826568.862178-660793286', 07:41:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:41:34 INFO - '_': '/tools/buildbot/bin/python'} 07:41:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:41:34 INFO - Downloading/unpacking psutil>=3.1.1 07:41:34 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 07:41:34 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 07:41:34 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 07:41:34 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 07:41:34 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 07:41:34 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 07:41:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:41:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:41:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:41:36 INFO - Installing collected packages: psutil 07:41:36 INFO - Running setup.py install for psutil 07:41:36 INFO - building 'psutil._psutil_linux' extension 07:41:36 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 07:41:37 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 07:41:37 INFO - building 'psutil._psutil_posix' extension 07:41:37 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 07:41:37 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 07:41:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:41:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:41:37 INFO - Successfully installed psutil 07:41:37 INFO - Cleaning up... 07:41:37 INFO - Return code: 0 07:41:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:41:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:41:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:41:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:41:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:41:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:37 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 0x2203030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2432400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c1570>, '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 0x24c2470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24c2900>, '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': '41bf3e9aed84707956354da8000001c5-1472826568.862178-660793286', '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 07:41:37 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 07:41:37 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 07:41:37 INFO - Using env: {'DISPLAY': ':0', 07:41:37 INFO - 'HOME': '/home/cltbld', 07:41:37 INFO - 'LANG': 'en_US.UTF-8', 07:41:37 INFO - 'LANGUAGE': 'en_US:en', 07:41:37 INFO - 'LOGNAME': 'cltbld', 07:41:37 INFO - 'MAIL': '/var/mail/cltbld', 07:41:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:41:37 INFO - 'MOZ_NO_REMOTE': '1', 07:41:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:41:37 INFO - 'NO_EM_RESTART': '1', 07:41:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:41:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:41:37 INFO - 'PWD': '/builds/slave/test', 07:41:37 INFO - 'SHELL': '/bin/bash', 07:41:37 INFO - 'SHLVL': '1', 07:41:37 INFO - 'TERM': 'linux', 07:41:37 INFO - 'TMOUT': '86400', 07:41:37 INFO - 'USER': 'cltbld', 07:41:37 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1472826568.862178-660793286', 07:41:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:41:37 INFO - '_': '/tools/buildbot/bin/python'} 07:41:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:41:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:41:37 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 07:41:37 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 07:41:37 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 07:41:37 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 07:41:37 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 07:41:37 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 07:41:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:41:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:41:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:41:39 INFO - Installing collected packages: mozsystemmonitor 07:41:39 INFO - Running setup.py install for mozsystemmonitor 07:41:39 INFO - Successfully installed mozsystemmonitor 07:41:39 INFO - Cleaning up... 07:41:39 INFO - Return code: 0 07:41:39 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:41:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:41:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:41:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:41:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:41:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:39 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 0x2203030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2432400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c1570>, '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 0x24c2470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24c2900>, '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': '41bf3e9aed84707956354da8000001c5-1472826568.862178-660793286', '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 07:41:39 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 07:41:39 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 07:41:39 INFO - Using env: {'DISPLAY': ':0', 07:41:39 INFO - 'HOME': '/home/cltbld', 07:41:39 INFO - 'LANG': 'en_US.UTF-8', 07:41:39 INFO - 'LANGUAGE': 'en_US:en', 07:41:39 INFO - 'LOGNAME': 'cltbld', 07:41:39 INFO - 'MAIL': '/var/mail/cltbld', 07:41:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:41:39 INFO - 'MOZ_NO_REMOTE': '1', 07:41:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:41:39 INFO - 'NO_EM_RESTART': '1', 07:41:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:41:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:41:39 INFO - 'PWD': '/builds/slave/test', 07:41:39 INFO - 'SHELL': '/bin/bash', 07:41:39 INFO - 'SHLVL': '1', 07:41:39 INFO - 'TERM': 'linux', 07:41:39 INFO - 'TMOUT': '86400', 07:41:39 INFO - 'USER': 'cltbld', 07:41:39 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1472826568.862178-660793286', 07:41:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:41:39 INFO - '_': '/tools/buildbot/bin/python'} 07:41:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:41:39 INFO - Downloading/unpacking jsonschema==2.5.1 07:41:39 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 07:41:39 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 07:41:39 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 07:41:39 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 07:41:39 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 07:41:39 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 07:41:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:41:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:41:41 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 07:41:41 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 07:41:41 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 07:41:41 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 07:41:41 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 07:41:41 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 07:41:42 INFO - Downloading functools32-3.2.3-2.tar.gz 07:41:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:41:42 INFO - warning: no files found matching '*.txt' 07:41:42 INFO - no previously-included directories found matching 'build' 07:41:42 INFO - no previously-included directories found matching 'dist' 07:41:42 INFO - no previously-included directories found matching '.git*' 07:41:42 INFO - Installing collected packages: jsonschema, functools32 07:41:42 INFO - Running setup.py install for functools32 07:41:42 INFO - warning: no files found matching '*.txt' 07:41:42 INFO - no previously-included directories found matching 'build' 07:41:42 INFO - no previously-included directories found matching 'dist' 07:41:42 INFO - no previously-included directories found matching '.git*' 07:41:42 INFO - Successfully installed jsonschema functools32 07:41:42 INFO - Cleaning up... 07:41:42 INFO - Return code: 0 07:41:42 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:41: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')]} 07:41:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:41:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41: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')]} 07:41:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:41:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:42 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 0x2203030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2432400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c1570>, '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 0x24c2470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24c2900>, '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': '41bf3e9aed84707956354da8000001c5-1472826568.862178-660793286', '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 07:41:42 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 07:41:42 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 07:41:42 INFO - Using env: {'DISPLAY': ':0', 07:41:42 INFO - 'HOME': '/home/cltbld', 07:41:42 INFO - 'LANG': 'en_US.UTF-8', 07:41:42 INFO - 'LANGUAGE': 'en_US:en', 07:41:42 INFO - 'LOGNAME': 'cltbld', 07:41:42 INFO - 'MAIL': '/var/mail/cltbld', 07:41:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:41:42 INFO - 'MOZ_NO_REMOTE': '1', 07:41:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:41:42 INFO - 'NO_EM_RESTART': '1', 07:41:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:41:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:41:42 INFO - 'PWD': '/builds/slave/test', 07:41:42 INFO - 'SHELL': '/bin/bash', 07:41:42 INFO - 'SHLVL': '1', 07:41:42 INFO - 'TERM': 'linux', 07:41:42 INFO - 'TMOUT': '86400', 07:41:42 INFO - 'USER': 'cltbld', 07:41:42 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1472826568.862178-660793286', 07:41:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:41:42 INFO - '_': '/tools/buildbot/bin/python'} 07:41:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:41:42 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:41:42 INFO - Cleaning up... 07:41:42 INFO - Return code: 0 07:41:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:41: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')]} 07:41:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:41:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41: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')]} 07:41:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:41:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:42 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 0x2203030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2432400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c1570>, '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 0x24c2470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24c2900>, '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': '41bf3e9aed84707956354da8000001c5-1472826568.862178-660793286', '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 07:41:42 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 07:41:42 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 07:41:42 INFO - Using env: {'DISPLAY': ':0', 07:41:42 INFO - 'HOME': '/home/cltbld', 07:41:42 INFO - 'LANG': 'en_US.UTF-8', 07:41:42 INFO - 'LANGUAGE': 'en_US:en', 07:41:42 INFO - 'LOGNAME': 'cltbld', 07:41:42 INFO - 'MAIL': '/var/mail/cltbld', 07:41:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:41:42 INFO - 'MOZ_NO_REMOTE': '1', 07:41:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:41:42 INFO - 'NO_EM_RESTART': '1', 07:41:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:41:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:41:42 INFO - 'PWD': '/builds/slave/test', 07:41:42 INFO - 'SHELL': '/bin/bash', 07:41:42 INFO - 'SHLVL': '1', 07:41:42 INFO - 'TERM': 'linux', 07:41:42 INFO - 'TMOUT': '86400', 07:41:42 INFO - 'USER': 'cltbld', 07:41:42 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1472826568.862178-660793286', 07:41:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:41:42 INFO - '_': '/tools/buildbot/bin/python'} 07:41:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:41:42 INFO - Downloading/unpacking blobuploader==1.2.4 07:41:42 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 07:41:42 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 07:41:42 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 07:41:42 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 07:41:42 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 07:41:42 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 07:41:44 INFO - Downloading blobuploader-1.2.4.tar.gz 07:41:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:41:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:41:44 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 07:41:44 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 07:41:44 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 07:41:44 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 07:41:44 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 07:41:44 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 07:41:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:41:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:41:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:41:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:41:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:41:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:41:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:41:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:41:45 INFO - Downloading docopt-0.6.1.tar.gz 07:41:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:41:45 INFO - Installing collected packages: blobuploader, requests, docopt 07:41:45 INFO - Running setup.py install for blobuploader 07:41:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:41:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:41:45 INFO - Running setup.py install for requests 07:41:45 INFO - Running setup.py install for docopt 07:41:46 INFO - Successfully installed blobuploader requests docopt 07:41:46 INFO - Cleaning up... 07:41:46 INFO - Return code: 0 07:41:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:41:46 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')]} 07:41:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:41:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:46 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')]} 07:41:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:41:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:46 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 0x2203030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2432400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c1570>, '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 0x24c2470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24c2900>, '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': '41bf3e9aed84707956354da8000001c5-1472826568.862178-660793286', '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 07:41:46 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 07:41:46 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 07:41:46 INFO - Using env: {'DISPLAY': ':0', 07:41:46 INFO - 'HOME': '/home/cltbld', 07:41:46 INFO - 'LANG': 'en_US.UTF-8', 07:41:46 INFO - 'LANGUAGE': 'en_US:en', 07:41:46 INFO - 'LOGNAME': 'cltbld', 07:41:46 INFO - 'MAIL': '/var/mail/cltbld', 07:41:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:41:46 INFO - 'MOZ_NO_REMOTE': '1', 07:41:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:41:46 INFO - 'NO_EM_RESTART': '1', 07:41:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:41:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:41:46 INFO - 'PWD': '/builds/slave/test', 07:41:46 INFO - 'SHELL': '/bin/bash', 07:41:46 INFO - 'SHLVL': '1', 07:41:46 INFO - 'TERM': 'linux', 07:41:46 INFO - 'TMOUT': '86400', 07:41:46 INFO - 'USER': 'cltbld', 07:41:46 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1472826568.862178-660793286', 07:41:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:41:46 INFO - '_': '/tools/buildbot/bin/python'} 07:41:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:41:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:41:46 INFO - Running setup.py (path:/tmp/pip-4cTNks-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:41:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:41:46 INFO - Running setup.py (path:/tmp/pip-atm3IY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:41:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:41:46 INFO - Running setup.py (path:/tmp/pip-fO3rWw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:41:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:41:46 INFO - Running setup.py (path:/tmp/pip-BScF3a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:41:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:41:46 INFO - Running setup.py (path:/tmp/pip-JCWwKk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:41:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:41:46 INFO - Running setup.py (path:/tmp/pip-3qpBgz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:41:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:41:46 INFO - Running setup.py (path:/tmp/pip-mJZeD8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:41:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:41:46 INFO - Running setup.py (path:/tmp/pip-RoIm5r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:41:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:41:46 INFO - Running setup.py (path:/tmp/pip-p7c4TW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:41:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:41:46 INFO - Running setup.py (path:/tmp/pip-ULNX_Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:41:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:41:47 INFO - Running setup.py (path:/tmp/pip-BvaYau-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:41:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:41:47 INFO - Running setup.py (path:/tmp/pip-6ClUq_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:41:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:41:47 INFO - Running setup.py (path:/tmp/pip-RAxDN7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:41:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:41:47 INFO - Running setup.py (path:/tmp/pip-iorfH1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:41:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:41:47 INFO - Running setup.py (path:/tmp/pip-8nfUJh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:41:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:41:47 INFO - Running setup.py (path:/tmp/pip-kDu5hC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:41:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:41:47 INFO - Running setup.py (path:/tmp/pip-CXPJlt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:41:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:41:47 INFO - Running setup.py install for manifestparser 07:41:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:41:47 INFO - Running setup.py install for mozcrash 07:41:47 INFO - Running setup.py install for mozdebug 07:41:47 INFO - Running setup.py install for mozdevice 07:41:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:41:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:41:47 INFO - Running setup.py install for mozfile 07:41:48 INFO - Running setup.py install for mozhttpd 07:41:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:41:48 INFO - Running setup.py install for mozinfo 07:41:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:41:48 INFO - Running setup.py install for mozInstall 07:41:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:41:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:41:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:41:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:41:48 INFO - Running setup.py install for mozleak 07:41:48 INFO - Running setup.py install for mozlog 07:41:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:41:48 INFO - Running setup.py install for moznetwork 07:41:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:41:48 INFO - Running setup.py install for mozprocess 07:41:48 INFO - Running setup.py install for mozprofile 07:41:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:41:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:41:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:41:48 INFO - Running setup.py install for mozrunner 07:41:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:41:48 INFO - Running setup.py install for mozscreenshot 07:41:49 INFO - Running setup.py install for moztest 07:41:49 INFO - Running setup.py install for mozversion 07:41:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:41:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:41:49 INFO - Cleaning up... 07:41:49 INFO - Return code: 0 07:41:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:41:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:41:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:41:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:41:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:41:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:49 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 0x2203030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2432400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c1570>, '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 0x24c2470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24c2900>, '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': '41bf3e9aed84707956354da8000001c5-1472826568.862178-660793286', '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 07:41:49 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 07:41:49 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 07:41:49 INFO - Using env: {'DISPLAY': ':0', 07:41:49 INFO - 'HOME': '/home/cltbld', 07:41:49 INFO - 'LANG': 'en_US.UTF-8', 07:41:49 INFO - 'LANGUAGE': 'en_US:en', 07:41:49 INFO - 'LOGNAME': 'cltbld', 07:41:49 INFO - 'MAIL': '/var/mail/cltbld', 07:41:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:41:49 INFO - 'MOZ_NO_REMOTE': '1', 07:41:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:41:49 INFO - 'NO_EM_RESTART': '1', 07:41:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:41:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:41:49 INFO - 'PWD': '/builds/slave/test', 07:41:49 INFO - 'SHELL': '/bin/bash', 07:41:49 INFO - 'SHLVL': '1', 07:41:49 INFO - 'TERM': 'linux', 07:41:49 INFO - 'TMOUT': '86400', 07:41:49 INFO - 'USER': 'cltbld', 07:41:49 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1472826568.862178-660793286', 07:41:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:41:49 INFO - '_': '/tools/buildbot/bin/python'} 07:41:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:41:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:41:49 INFO - Running setup.py (path:/tmp/pip-k3z_Hx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:41:49 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)) 07:41:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:41:49 INFO - Running setup.py (path:/tmp/pip-InWhPi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:41:49 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)) 07:41:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:41:49 INFO - Running setup.py (path:/tmp/pip-xiz3Lm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:41:49 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)) 07:41:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:41:49 INFO - Running setup.py (path:/tmp/pip-5coWEB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:41:49 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)) 07:41:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:41:49 INFO - Running setup.py (path:/tmp/pip-DeA4fv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:41:49 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)) 07:41:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:41:49 INFO - Running setup.py (path:/tmp/pip-ThQ0OA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:41:49 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)) 07:41:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:41:49 INFO - Running setup.py (path:/tmp/pip-wc48TM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:41:50 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)) 07:41:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:41:50 INFO - Running setup.py (path:/tmp/pip-ZmsTLw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:41:50 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)) 07:41:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:41:50 INFO - Running setup.py (path:/tmp/pip-VbraGk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:41:50 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)) 07:41:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:41:50 INFO - Running setup.py (path:/tmp/pip-eIo6wk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:41:50 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)) 07:41:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:41:50 INFO - Running setup.py (path:/tmp/pip-TAqhdb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:41:50 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)) 07:41:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:41:50 INFO - Running setup.py (path:/tmp/pip-QKXAxn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:41:50 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)) 07:41:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:41:50 INFO - Running setup.py (path:/tmp/pip-9KJd1z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:41:50 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)) 07:41:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:41:50 INFO - Running setup.py (path:/tmp/pip-H2HBDS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:41:50 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)) 07:41:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:41:50 INFO - Running setup.py (path:/tmp/pip-4GdJ1D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:41:50 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)) 07:41:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:41:50 INFO - Running setup.py (path:/tmp/pip-2aaaHi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:41:50 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)) 07:41:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:41:50 INFO - Running setup.py (path:/tmp/pip-SXd7YS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:41:50 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)) 07:41:50 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)) 07:41:50 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)) 07:41:50 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)) 07:41:50 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)) 07:41:50 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)) 07:41:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:41:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:41:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:41:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:41:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:41:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:41:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:41:52 INFO - Downloading blessings-1.6.tar.gz 07:41:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:41:52 INFO - Installing collected packages: blessings 07:41:52 INFO - Running setup.py install for blessings 07:41:52 INFO - Successfully installed blessings 07:41:52 INFO - Cleaning up... 07:41:52 INFO - Return code: 0 07:41:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:41:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:41:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:41:53 INFO - Reading from file tmpfile_stdout 07:41:53 INFO - Current package versions: 07:41:53 INFO - argparse == 1.2.1 07:41:53 INFO - blessings == 1.6 07:41:53 INFO - blobuploader == 1.2.4 07:41:53 INFO - docopt == 0.6.1 07:41:53 INFO - functools32 == 3.2.3-2 07:41:53 INFO - jsonschema == 2.5.1 07:41:53 INFO - manifestparser == 1.1 07:41:53 INFO - mozInstall == 1.12 07:41:53 INFO - mozcrash == 0.17 07:41:53 INFO - mozdebug == 0.1 07:41:53 INFO - mozdevice == 0.48 07:41:53 INFO - mozfile == 1.2 07:41:53 INFO - mozhttpd == 0.7 07:41:53 INFO - mozinfo == 0.9 07:41:53 INFO - mozleak == 0.1 07:41:53 INFO - mozlog == 3.3 07:41:53 INFO - moznetwork == 0.27 07:41:53 INFO - mozprocess == 0.23 07:41:53 INFO - mozprofile == 0.28 07:41:53 INFO - mozrunner == 6.12 07:41:53 INFO - mozscreenshot == 0.1 07:41:53 INFO - mozsystemmonitor == 0.3 07:41:53 INFO - moztest == 0.7 07:41:53 INFO - mozversion == 1.4 07:41:53 INFO - psutil == 3.1.1 07:41:53 INFO - requests == 1.2.3 07:41:53 INFO - wsgiref == 0.1.2 07:41:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:41: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')]} 07:41:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:41:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41: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')]} 07:41:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:41:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:53 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 0x2203030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2432400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c1570>, '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 0x24c2470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24c2900>, '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': '41bf3e9aed84707956354da8000001c5-1472826568.862178-660793286', '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 07:41:53 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 07:41:53 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 07:41:53 INFO - Using env: {'DISPLAY': ':0', 07:41:53 INFO - 'HOME': '/home/cltbld', 07:41:53 INFO - 'LANG': 'en_US.UTF-8', 07:41:53 INFO - 'LANGUAGE': 'en_US:en', 07:41:53 INFO - 'LOGNAME': 'cltbld', 07:41:53 INFO - 'MAIL': '/var/mail/cltbld', 07:41:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:41:53 INFO - 'MOZ_NO_REMOTE': '1', 07:41:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:41:53 INFO - 'NO_EM_RESTART': '1', 07:41:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:41:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:41:53 INFO - 'PWD': '/builds/slave/test', 07:41:53 INFO - 'SHELL': '/bin/bash', 07:41:53 INFO - 'SHLVL': '1', 07:41:53 INFO - 'TERM': 'linux', 07:41:53 INFO - 'TMOUT': '86400', 07:41:53 INFO - 'USER': 'cltbld', 07:41:53 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1472826568.862178-660793286', 07:41:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:41:53 INFO - '_': '/tools/buildbot/bin/python'} 07:41:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:41:53 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)) 07:41:53 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)) 07:41:53 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)) 07:41:53 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)) 07:41:53 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)) 07:41:53 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)) 07:41:53 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)) 07:41:53 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)) 07:41:53 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)) 07:41:53 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)) 07:41:53 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)) 07:41:53 INFO - Cleaning up... 07:41:53 INFO - Return code: 0 07:41:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:41: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')]} 07:41:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:41:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41: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')]} 07:41:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:41:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2203030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2432400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c1570>, '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 0x24c2470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24c2900>, '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': '41bf3e9aed84707956354da8000001c5-1472826568.862178-660793286', '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 07:41: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', 'jsonschema'] in /builds/slave/test/build 07:41: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 jsonschema 07:41:53 INFO - Using env: {'DISPLAY': ':0', 07:41:53 INFO - 'HOME': '/home/cltbld', 07:41:53 INFO - 'LANG': 'en_US.UTF-8', 07:41:53 INFO - 'LANGUAGE': 'en_US:en', 07:41:53 INFO - 'LOGNAME': 'cltbld', 07:41:53 INFO - 'MAIL': '/var/mail/cltbld', 07:41:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:41:53 INFO - 'MOZ_NO_REMOTE': '1', 07:41:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:41:53 INFO - 'NO_EM_RESTART': '1', 07:41:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:41:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:41:53 INFO - 'PWD': '/builds/slave/test', 07:41:53 INFO - 'SHELL': '/bin/bash', 07:41:53 INFO - 'SHLVL': '1', 07:41:53 INFO - 'TERM': 'linux', 07:41:53 INFO - 'TMOUT': '86400', 07:41:53 INFO - 'USER': 'cltbld', 07:41:53 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1472826568.862178-660793286', 07:41:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:41:53 INFO - '_': '/tools/buildbot/bin/python'} 07:41:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:41:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:41:53 INFO - Cleaning up... 07:41:53 INFO - Return code: 0 07:41:53 INFO - Running post-action listener: _resource_record_post_action 07:41:53 INFO - Running post-action listener: _start_resource_monitoring 07:41:53 INFO - Starting resource monitoring. 07:41:53 INFO - [mozharness: 2016-09-02 14:41:53.576326Z] Finished create-virtualenv step (success) 07:41:53 INFO - [mozharness: 2016-09-02 14:41:53.576805Z] Running install step. 07:41:53 INFO - Running pre-action listener: _resource_record_pre_action 07:41:53 INFO - Running main action method: install 07:41:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:41:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:41:53 INFO - Reading from file tmpfile_stdout 07:41:53 INFO - Detecting whether we're running mozinstall >=1.0... 07:41:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:41:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:41:53 INFO - Reading from file tmpfile_stdout 07:41:53 INFO - Output received: 07:41:53 INFO - Usage: mozinstall [options] installer 07:41:53 INFO - Options: 07:41:53 INFO - -h, --help show this help message and exit 07:41:53 INFO - -d DEST, --destination=DEST 07:41:53 INFO - Directory to install application into. [default: 07:41:53 INFO - "/builds/slave/test"] 07:41:53 INFO - --app=APP Application being installed. [default: firefox] 07:41:53 INFO - mkdir: /builds/slave/test/build/application 07:41:53 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'] 07:41:53 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 07:42:10 INFO - Reading from file tmpfile_stdout 07:42:10 INFO - Output received: 07:42:10 INFO - /builds/slave/test/build/application/firefox/firefox 07:42:10 INFO - Running post-action listener: _resource_record_post_action 07:42:10 INFO - [mozharness: 2016-09-02 14:42:10.247080Z] Finished install step (success) 07:42:10 INFO - [mozharness: 2016-09-02 14:42:10.247359Z] Running run-tests step. 07:42:10 INFO - Running pre-action listener: _resource_record_pre_action 07:42:10 INFO - Running main action method: run_tests 07:42:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:42:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:42:10 INFO - Python 2.7.3 07:42:10 INFO - Return code: 0 07:42:10 INFO - grabbing minidump binary from tooltool 07:42:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:42:10 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 0x24c1570>, '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 0x24c2470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24c2900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:42:10 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 07:42:10 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 07:42:10 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 07:42:10 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:42:10 INFO - Return code: 0 07:42:10 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:42:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:42:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:42:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:42:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:42:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZRc_JytXSZepOmvw-0WyWg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 07:42:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZRc_JytXSZepOmvw-0WyWg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-026 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 07:42:10 INFO - Using env: {'DISPLAY': ':0', 07:42:10 INFO - 'HOME': '/home/cltbld', 07:42:10 INFO - 'LANG': 'en_US.UTF-8', 07:42:10 INFO - 'LANGUAGE': 'en_US:en', 07:42:10 INFO - 'LOGNAME': 'cltbld', 07:42:10 INFO - 'MAIL': '/var/mail/cltbld', 07:42:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:42:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:42:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:42:10 INFO - 'MOZ_NO_REMOTE': '1', 07:42:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:42:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:42:10 INFO - 'NO_EM_RESTART': '1', 07:42:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:42:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:42:10 INFO - 'PWD': '/builds/slave/test', 07:42:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:42:10 INFO - 'SHELL': '/bin/bash', 07:42:10 INFO - 'SHLVL': '1', 07:42:10 INFO - 'TERM': 'linux', 07:42:10 INFO - 'TMOUT': '86400', 07:42:10 INFO - 'USER': 'cltbld', 07:42:10 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1472826568.862178-660793286', 07:42:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:42:10 INFO - '_': '/tools/buildbot/bin/python'} 07:42:10 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZRc_JytXSZepOmvw-0WyWg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 07:42:10 INFO - mozversion application_buildid: 20160902045242 07:42:10 INFO - mozversion application_changeset: b16b9d1eea136bba9d512610e79700192be4e646 07:42:10 INFO - mozversion application_display_name: FirefoxDeveloperEdition 07:42:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:42:10 INFO - mozversion application_name: Firefox 07:42:10 INFO - mozversion application_remotingname: firefox-dev 07:42:10 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:42:10 INFO - mozversion application_vendor: Mozilla 07:42:10 INFO - mozversion application_version: 50.0a2 07:42:10 INFO - mozversion platform_buildid: 20160902045242 07:42:10 INFO - mozversion platform_changeset: b16b9d1eea136bba9d512610e79700192be4e646 07:42:10 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:42:10 INFO - mozversion platform_version: 50.0a2 07:42:10 INFO - using testdate: 1472827330 07:42:10 INFO - actual date: 1472827330 07:42:10 INFO - starting webserver on 'localhost:47254' 07:42:10 INFO - SUITE-START | Running 2 tests 07:42:10 INFO - TEST-START | dromaeo_css 07:42:10 INFO - operating with platform_type : linux_ 07:42:10 INFO - Initialising browser for dromaeo_css test... 07:42:10 INFO - TEST-INFO | started process 24527 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpj2wizY/profile http://localhost:47254/getInfo.html) 07:42:14 INFO - PROCESS | 24527 | __metrics Screen width/height:1600/1200 07:42:14 INFO - PROCESS | 24527 | colorDepth:24 07:42:14 INFO - PROCESS | 24527 | Browser inner width/height: 1024/697 07:42:14 INFO - PROCESS | 24527 | __metrics 07:42:15 ERROR - PROCESS | 24527 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 07:42:16 INFO - TEST-INFO | 24527: exit 0 07:42:16 INFO - Browser initialized. 07:42:16 INFO - Running cycle 1/1 for dromaeo_css test... 07:42:16 INFO - TEST-INFO | started process 24652 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpj2wizY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:42:28 INFO - PROCESS | 24652 | RSS: Main: 152834048 07:42:28 INFO - PROCESS | 24652 | 07:43:17 INFO - PROCESS | 24652 | 1472827397751 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] 07:45:26 INFO - PROCESS | 24652 | Cycle 1(1): loaded http://localhost:47254/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47254/tests/dromaeo/cssquery-ext.html) 07:45:27 INFO - PROCESS | 24652 | RSS: Main: 158371840 07:45:27 INFO - PROCESS | 24652 | 07:48:29 INFO - PROCESS | 24652 | Cycle 1(1): loaded http://localhost:47254/tests/dromaeo/cssquery-ext.html (next: http://localhost:47254/tests/dromaeo/cssquery-jquery.html) 07:48:29 INFO - PROCESS | 24652 | RSS: Main: 154062848 07:48:29 INFO - PROCESS | 24652 | 07:51:31 INFO - PROCESS | 24652 | Cycle 1(1): loaded http://localhost:47254/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47254/tests/dromaeo/cssquery-mootools.html) 07:51:32 INFO - PROCESS | 24652 | RSS: Main: 155226112 07:51:32 INFO - PROCESS | 24652 | 07:54:34 INFO - PROCESS | 24652 | Cycle 1(1): loaded http://localhost:47254/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47254/tests/dromaeo/cssquery-prototype.html) 07:54:34 INFO - PROCESS | 24652 | RSS: Main: 153010176 07:54:34 INFO - PROCESS | 24652 | 07:57:37 INFO - PROCESS | 24652 | Cycle 1(1): loaded http://localhost:47254/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47254/tests/dromaeo/cssquery-yui.html) 07:57:37 INFO - PROCESS | 24652 | RSS: Main: 155549696 07:57:37 INFO - PROCESS | 24652 | 08:00:40 INFO - PROCESS | 24652 | Cycle 1(1): loaded http://localhost:47254/tests/dromaeo/cssquery-yui.html (next: http://localhost:47254/tests/dromaeo/cssquery-dojo.html) 08:00:40 INFO - PROCESS | 24652 | RSS: Main: 156766208 08:00:40 INFO - PROCESS | 24652 | 08:00:40 INFO - PROCESS | 24652 | __start_tp_report 08:00:40 INFO - PROCESS | 24652 | _x_x_mozilla_page_load 08:00:40 INFO - PROCESS | 24652 | _x_x_mozilla_page_load_details 08:00:40 INFO - PROCESS | 24652 | |i|pagename|runs| 08:00:40 INFO - PROCESS | 24652 | |0;dojo.html;3288.8684452621897;3301.0591981285324;3313.155145437913;3323.534705141279;3334.733221342293;5767.8269651910405;5839;5845.357010728827;5852.034414321637;5863.442972917576;5747.626404283718;5797.594168408213;5799.333076696181;5812.1281807728865;5826.679532625714;5225.634205605609;5239.921401178975;5251.159814429692;5286.762095705683;5301.257823904656;5047.293378926953;5056.241563765446;5136.383633963929;5155.432902380735;5251.868703282429;5159.5614372778355;5171.17261238202;5184.326037615105;5222.425533191365;5281.815136470224;5255.816046438375;5262.315898933152;5271.604629652791;5272.789088436458;5289.44460831611;4932.235503496964;4937.851864444073;4962.1812400953795;5175.249588809639;5176.378834539879;5088.821891233789;5601.467860553241;5640.633358831663;5644.6330988486025;5672.886542269172;6014.729337179838;6053.788117415913;6068.878622427526;6083.117947897575;6097.237845269341;5941.762329506814;6143.354947730513;6145.446909778141;6148.047052706837;6163.938360616381;5711.971440142773;5763.106718458645;5764.654120752726;5830.067189249699;5871.4715675589405;6349.301576826545;6372.394622510854;6380.074889141141;6389.520785941073;6400.327965563642;5898.734556944948;6050.213472248667;6114.938850611526;6116.480099191618;6119.265688117365;6116.602420842631;6133.84665383369;6140.846478838065;6220.595661282002;6221.160143380585;6118.969405152946;6182.227221597301;6193.977993631001;6201.56589038772;6206;5900.970495147497;6201;6213.347598502092;6228.096925945712;6229.719662615103;4558.544145585482;4596.839110631112;4600.470945841204;4638.234691275901;4674.252119660906;4105.322621767435;4109.3425051991535;4132.884121287236;4155.3766934959995;4161.146964872194;5706.885862282731;5758.74085666146;5799.217105690762;5801.6809075500405;5814.825555233349;6073.331933487401;6108.175396321529;6131.96934015327;6164.106204600397;6181.8454538636;5826.1552074948895;5839.766409343579;5840.036393994943;5863.442972917651;5868.530517558585;5184.585233181337;5283.313169287968;5289.894202116013;5296.179092240709;5311.893762124736;6246.344133865879;6250.374962503804;6260.217472815898;6421.068945003042;6424.036394540763;6195.96902015478;6199.938000620116;6205.627662340274;6209.813705588839;6210.968945155245;6140.508759299156;6351.587146835441;6374.808755737336;6382.5532212744665;6401.839954001187;5985.25184351956;5999.010163323002;6009.939900600938;6088.299845517822;6129.84675383119;6152.907706384318;6159.071045074292;6176.6911654418;6191.907121393093;6197.752089916353;5814.622049566765;6009.798040391852;6014.879702405839;6030.095485677008;6043.607165534227;5988;6023.1567580537885;6029.969850150721;6116.792316687851;6141.815745527641;6030.939690603038;6060.939390606038;6071.332153463204;6077.6961151943115;6113;5865.14955331466;6048.818535443944;6101.542384321105;6125.724342404514;6138.693065346804;5739.5695322850115;5758.395368486416;5817.0983497557945;5915.674637894957;5943.64338139713 08:00:40 INFO - PROCESS | 24652 | |1;ext.html;591.7130191856951;647.4593714248603;654.1496055128332;673.1551902362535;683.4498228925713;40919.79540102299;46292.07415851681;46592;46694.533054669446;46729.76635116824;47196;47733;47750;47793;47920;8975.82048359034;9057.049009853969;9105;9109.453432794053;9110.316726245524;9112.681056163035;9192.770180745469;9202.539873006357;9203.217726493256;9218.262538996863;9196.908030919672;9224.492652904088;9229;9250.86123708145;9259.814803703955;9164.8625270621;9187.954060229657;9192.862107068366;9209.171174594285;9219.35464517484;9009.189172974398;9089.227415669677;9114.498702571356;9130.817383652357;9172.908270917338;44265.55734442679;44547.10905781898;44695.55304446979;44741.55258447406;44899.55100448986;3826.617338266179;4159.043420013414;4165.812538435777;4456.799444024994;4753.287006948951;35163.29673406543;35216.647833521594;35617;35931.4610280846;37015.81492092549;4266.850660226908;4319.222539942809;4327.112941846945;4357.629601483878;4403;365326.9999999973;367621;367903;369275;370692;66531.66734166298;66893;67019.32980670228;67037.66481167563;67223.32776672268;40379.394309085386;42410.78794606069;43217.783911080245;43242.783786080865;43309;18706.625867482573;18952.715709264372;18960;18967.241310347432;18993.62012759737;14303.21332326732;14366.066205696805;14378.065425747292;14378.784318235235;14392.280385980659;21220.78779212219;21412.464688382915;21582.35252942414;21597.67603485949;21805.890970545046;7435.925640743631;7797.532148071134;7896.20981928666;7951.051992261817;7959.761207163794;1022.1822541966397;1083.4366129612558;1105.237386203517;1132.326265871805;1155.942202889852;33792.32415351679;34102.65897341044;34203;34211.144721381665;34422.82788586041;1141.3323205924462;1154.451461242701;1165.0737663557493;1167.0430247197216;1180.7874582575218;18142.727859082126;18228;18266.634667306844;18270.63458730818;18418.815811841978;607833;612178;619449;620619;621316;65151;65610.67194664091;65645;65719.67140164365;66020.66989665022;1407.3385508810843;1435.9712805743827;1465.5969608357573;1468.9045212061396;1477.2613693153423;32240.19399514937;33249.501257480675;33566;33599.16002099967;33660.158496037795;58150.12774808297;58432.4156758427;58773.412265876796;58791.70604146952;58846;391087;391097;391153;392427;392532;31625.468016009265;31722.682773172895;31745.682543174273;31980.840095799373;32034.839825801653;51840.74079629578;52299;52623;52886.73556632346;52939.73530132325;44330.335044975;44959.32561011653;45165;46733.532664674276;49624;46272;46515;46667;47303.29045064258;47409.7629511864;45160.54839451564;45436.77281613571;46046;46179.76910115428;46328.768356158005;39788.403173953;39996.60003399929;40546.797266013484;40874.007718301924;40896;30618.387632247675;30976.84511577428;31098.844505777328;31135.221619459695;31258 08:00:40 INFO - PROCESS | 24652 | |2;jquery.html;396.1976996581923;402.1293898709293;402.89726119839446;407.4173931278272;423.19803971474056;19334.32329868455;20729.378118656463;21220.363389098315;21234.681479777795;21457.356279311607;13115.934420327885;13415.396307166176;19569.804301956978;21102.261420850275;21346.03942822573;5444.128939369702;5518.944810551883;5520.254765606632;5594.8601284968;5599.692016939067;5344.625876188668;5458.044842152627;5458.153986132136;5461.2354270402175;5495.477929596682;5355.357357117132;5521.365043020064;5561.805336813212;5588.720563971785;5596.132599447093;5430.104032834578;5511.311086114236;5551.555875529948;5590.524805391527;5590.972045139789;5242.711650859239;5399.271098401705;5408.945910540923;5413.106837371829;5413.485718856702;24671.876640616683;24882.502349952898;24924.626130608056;25516.234512964642;25694.229173124837;2541.1507285295033;2614.843109413422;2641.220839852248;2703.4322792213657;3074.8616312266004;10383.688489345332;10661.466926653713;10775.515101820436;10967.122630189646;11347.581552305961;2005.177877070394;2034.013503450825;2038.194913009353;2046.2224354745251;2064.3394113883564;77395;90074.54962725144;91250;92433;92758;11353.886461135447;11373.545058197746;11449.713757156138;11637.127215458875;11775.646730597924;16318.428854990017;16339.18304084791;16344.591385215464;16354;16378.181090945405;8590.226879580743;8807.383483156245;8813.162749538784;8829.381943264038;8912.777180570538;8565.400421970528;8595.269402100766;8646.481211127353;8741.213290803858;8774.60514276859;4859.538343857328;4892.633052521075;4948.727819969864;4960.131976904027;5047.873803154877;2010.3064442767222;2027.9797202028085;2071.7099606055162;2072.3161356752234;2084.1767501836994;935.6538080910107;1073.951672174754;1092.4537731134433;1106.0755076926143;1111.988090837334;20566;21344.14623415046;21424.15847898422;21569.78430215709;21603.811790351683;1040.7450174707244;1046.210111365914;1085.9837102443469;1110.0453609895483;1160.6692092753694;11248.381339026431;11527.308361498337;11739.11956603241;11822.467988940347;11852.11109166816;546757;551877;557589;582770;583232;95818.52090739501;96013.5199324013;99533.50233248933;100045;100250;1056.1972900595604;1066.221658189526;1108.8281316395971;1109.1681239070697;1110.5169251375678;18452.723209152144;18635.72046419278;19059.33292334817;19213.423597292105;19445.416637500897;46040;46232.075358491966;46721;47077.529224707316;47429;66346;66548;68522.31477685159;69289.30710692829;70977.64511177411;7969.880451793112;8444.619992100248;8794.780130496532;8810.383273170817;9000.234980026771;13521.18872867631;13726.86273137256;13767.242801645605;13977.58067257984;14023.929880350533;12199.69500762488;12622.684432889251;12664.176828506117;12665.430055647334;12729.681757956125;11851.822222666839;12036.157468977088;12335;12413.44139513706;12593.496260149857;12495.687607809878;12558.183718058297;12612.621621351374;12641.178323408949;12885.42015609281;8021.639026243716;8194.631241594261;8212.83574328522;8389.874151887605;8478.02502712196;12062.45718942632;12070.155089144027;12310;12474.376281185723;12793.168444051107 08:00:40 INFO - PROCESS | 24652 | |3;mootools.html;1602.8121613996893;1607.4615003973668;1838.4392760208138;1897.1842107893601;1902.362708492655;8114.91885081149;8548.70079547216;8808.77978050549;9165.220956218722;9175;8873.778155546115;9155.90844091559;9226.907730922689;9236.8614470783;9238.30712696547;2367.23065003874;2388.79695225906;2391.5336509380677;2392.2105705117356;2403.9639405408934;2398.2325655790155;2432.3675844280438;2478.0583378316214;2480.8015358771254;2484.627305904111;2470.765277298654;2478.7273399926084;2486.8632225227607;2501.6122501012374;2501.69979602448;2403.122860156039;2404.89177986991;2411.1319924827135;2412.1195763546357;2433.525462534789;2413.6500207469994;2417.504411595619;2418.9879050604636;2419.806415486757;2440.133752517866;9241.168294853496;9263.490508022056;9271.860922086174;9278.814423711556;9364.719058428258;5365.302510673627;5449.509544141007;5486.972565137189;5493.615446918718;5500.28496295479;3299.2411745298477;3396.8111161093666;3433.484977253407;3438.449848024304;3449.4308439107517;1174.0666170394557;1201.1411840533972;1211.4669545399995;1220.9755804883941;1248.2073883084215;12700;12717.554885579053;12780.936095319465;12785.488580456771;12850.293233872133;4453.955460445419;4583.312503124492;4710.788014539354;4720.362751028636;4726.740029298353;10764.78470430587;10800.837987430195;10860.619878304222;10891.945540272249;10920.890791092146;5423.105187643994;5479.3424789024775;5483.945160548423;5488.725563721798;5492.835214943558;4503.076869241798;4819.975900120477;4904.190808516626;4962.15643340633;5094.923576146361;4141.316682747373;4145.489594046058;4198.664106871504;4210.957890421118;4214.978925105416;1244.5146392906775;1271.5295340723992;1277.3994731348514;1283.9743205135844;1287.0861688201294;1065.1585247654266;1072.951717172729;1085.4572713643179;1090.2531765740493;1104.0560320925492;6162.106494558354;6195.752169913243;6347.174867267318;6433.646149461731;6434.227892652912;451.5304083752926;451.6928488627699;461.04563553444046;467.7965085187954;467.9812807487662;4359.80380882861;4394.758288294111;4474.440694913136;4511.616512596401;4599.1721490132095;11179.66461006171;11486.0811135109;11524.250923689933;11574.363410012362;11592.594259200887;10409.323393979366;10817.621383251548;11454.713632159095;11507.597234096766;11508.712282193012;8360.163983601591;8590.527520986281;8610.741677749678;8613.440126391764;8614.095519970439;6103.0405489645145;6222.222222222223;6225.190725205694;6337.081123237012;6462.289148193601;9952.950235248778;10003.199744020316;10080.798384032132;10082.04220599042;10094.192464602667;10058.698239052841;10149.23880708935;10243.07812296897;10276.17790576767;10356.689299321033;7375.2256013119995;8167.305779008851;8220.465669731448;8295.58522073906;8678.175573320525;8698.26064784475;8914.687985920462;8956.149165829236;8982.86525702128;8989.595468203815;8033.11635720082;8052.114267430695;8061.2744852963515;8238.299744521782;8390.077091519806;7889.605519724106;7928.563928983961;8060.355171586376;8082.272595466201;8094.069182043905;7271;7376.373008294355;7381.077365329334;7443.590602516913;7450.552966822008;5465.234867118686;5547.861303467445;5670.829875103588;5672;5745.482906538432;5484.561235101262;5499.560035197094;5604.607677462702;5721.456461636138;5802.854928626649 08:00:40 INFO - PROCESS | 24652 | |4;prototype.html;312.8060602426495;322.17844496533843;327.2277425276349;333.5613668026546;342.07127648434493;5609.298837645294;5710.600257981943;5810.941890581093;5836.562257830664;5852.707364631768;5670.3479099903425;5690.260266165393;5720.484071720997;5725;5742.081266997281;4460.33095035744;4476.507584165739;4479.596836284733;4481.2523115984795;4531.524189960056;4419.62433193179;4461.687681862271;4465.955340446602;4480.283154695249;4486.932696009562;4411.09572537629;4425.889352766175;4426.269665505204;4435;4440.511543730187;4480.252701446439;4497.775111244458;4499.977500112478;4501.774911254424;4510.345999830006;3761.8307176177136;3860.7297489175767;3881.4565960765517;3885.2229554089295;3903.434002069684;5597.7201139943245;5611.298587676541;5676.772929082832;5690.430956904318;5706.942930570683;5061.190209566452;5158.92261616076;5162.819301324474;5169.793208271664;5186.273921650972;6016.548758843104;6030.155778191057;6031.531869175242;6055.788047418363;6084.726187321581;4262.126264115849;4263.936040959357;4292.613664770186;4308.375285583573;4308.418363520916;6140.877182456371;6282.120503129566;6357.872842543124;6378.321105135808;6380.872382552369;4407.933880991788;4408.382826404306;4410.117976404732;4439.556044395599;4442.244818380883;4490.595846373842;4495.685302028826;4496.505384407713;4499.77501124949;4504.189245935763;5005.574526165244;5132.717700526507;5165.070287348313;5187.740612969412;5213.817516386908;5878.617889837147;6032;6040.244969378828;6059.272887253558;6090.543209259324;1512.4177191781243;1521.8021657184718;1532.1573134775829;1536.523677659929;1541.537538738374;916.1525588830306;950.1686024728363;969.8836139663285;982.381099907054;990.6928852055742;5156.74216289184;5182.2485739567555;5198.84403467889;5199.2201169824075;5224.216367544898;5446.945530544723;5454.400015998237;5476.835694929158;5510.1459273812625;5588.552915766729;5043.697378157249;5257.921131183035;5295.372669721253;5300.522952934254;5317.8936421271355;2968.5547167924983;2977.553366994968;2980.4933161362187;2982.895598654037;2984.925376865596;5537.8061767837935;5545.417731138253;5696.544276457957;5715.228444160069;5758.7696492140685;5226.5818734501145;5533.806316778893;5541.667499950016;5548.500634942875;5562.3047119110115;5617.494425501724;5647.717614119278;5648.943510564924;5658.490735833712;5675.347335056521;5140.41213790393;5435.619506634498;5478.479544443271;5490.670559766427;5498.45015498447;5417.42894560573;5424.593155513273;5436.809711660073;5458.5087342139395;5462.754176062166;5627.396192085236;5639.887202256014;5673.290838645169;5675.694590244184;5718.714064296852;4007.579204183519;4034.4755181826176;4093.0381360380884;4414.735115893057;4416.514183439884;6069.969650151721;6157.353477884937;6195.783147589813;6221.875562488815;6235.3452887446165;6017.217761690952;6047.669512707197;6080.604760690541;6088.786892458743;6107.328193898578;6035.818925432244;6039.969800150971;6047.758089676364;6067.302260240129;6140.263168419819;5910.674912879833;6065.119812858028;6124.234470691164;6138.478229350377;6144.78493252734;6175.197224360804;6187.288461826947;6211.81364559064;6223.502119830312;6226.205821517316;5817.883642327214;5950.553708471795;6020.578559500793;6032.607880487754;6037.94335991191 08:00:40 INFO - PROCESS | 24652 | |5;yui.html;808.5431731071944;854.8845905802718;856.5631527920758;872.9432586881852;885.7608445719655;16974.83025169748;17528.47414577563;17628.118594070278;17788.64422711545;17913;16636.50090497284;16639.251233694482;16806.075665838373;16848.578785530368;16891.577710557212;887.6715615222361;913.6756451459736;922.4695799915042;923.3351986569659;925.255169588481;891.0643823984823;893.2362829780542;898.3397203055749;898.6989358564889;900.5677274908048;959.8176346494179;960.9087136722035;962.1581116523042;962.4706411473696;963.7590602349412;946.7775072857872;952.3286083311249;952.3381250031231;953.7234202081388;956.5121787888193;695.8086526205284;696.345435290825;696.6656005117521;697.1285892634207;700.1248439450686;15711.21443927799;15779.684406311924;15923.840761592352;15926.681466370608;15932.920335398365;13889.374978126009;14040.789388159186;14323.14061156334;14325.283735813167;14527.854721452755;11471.770564588745;11508.654740357802;11717.707057323634;11981.400929953468;12432.254064756144;3987.7806720630356;4101.733387329814;4151.709380343377;4221.810018549173;4267.573242675739;59019.40980590182;67672.3232767671;84475.5776221121;86002.49937515621;87018;12231.938840305742;12567.811482827765;12697.55558555446;12730.936345318214;12901.612951611467;22609.88695056547;22767.544649106923;22844.65733014006;22896;23027.309180724606;9136.908630913738;9267.582958766738;9289.303302252223;9389.812203755886;9415.623375065057;4906.067847109038;4998.275250088716;5017.623678224148;5047.722375269322;5073.340465739504;3553.591336996227;3712.3132220539287;3716.9814150929074;3725.7950812705562;3729.272791805626;639.2137670665107;648.8183308673579;658.2824721054074;658.5159907468008;673.5756473421714;802.8835818806241;808.1756608259542;812.4962523235632;861.2593169873903;867.4144952157269;10207.693769186937;10669.679909602724;11096.833547496793;11109.888901111048;11443.828342574869;707.4305184326564;745.5005146551823;765.0608976582345;804.5172896262196;812.2811311988933;5363.605462579757;5497.202905578669;5513.448655134534;5596.748146333425;5621.100623900156;78168;95065;131056;135976;137173.3141334287;86152.56923715341;88449;93773;116617;121830.3908480452;82836.99999999879;83510;93648;94319;95265;10629.427888143906;10742.140628749838;10755.354678719303;11038.779224415628;11073.778524429305;54897.725511373785;55009;55970;56209.43790562042;56312.71843640756;73423.26576734378;81740.59129704314;81785.59107204426;81840.59079704563;82303.58848205721;13992.720145597235;14023.228722419957;14128.858711412755;14174.645633858823;14277.214753188675;15133.848661513684;15209.391624335345;15252;15339.463118790789;15355.539333820003;14046.78929816033;14094.647633809236;14126.293685315899;14224;14397;14948.626284342978;15758.448454304043;16004.759928601314;16163.919180404022;16320.918395407947;13667.316634168053;14293.28533573338;14407.855921440652;14873;14914.627134321729;11262.267952583055;11306.152038596974;11869.940650296694;12148.453319600463;12169.39153042362;10906.836397453886;12017.63947081589;12320.691982700504;12481.625551233477;12582.496700131893 08:00:40 INFO - PROCESS | 24652 | __end_tp_report 08:00:40 INFO - PROCESS | 24652 | __start_cc_report 08:00:40 INFO - PROCESS | 24652 | _x_x_mozilla_cycle_collect,342 08:00:40 INFO - PROCESS | 24652 | __end_cc_report 08:00:40 INFO - PROCESS | 24652 | __startTimestamp1472828440636__endTimestamp 08:00:40 INFO - PROCESS | 24652 | 08:00:40 INFO - PROCESS | 24652 | ------- Summary: start ------- 08:00:40 INFO - PROCESS | 24652 | Number of tests: 6 08:00:40 INFO - PROCESS | 24652 | 08:00:40 INFO - PROCESS | 24652 | [#0] dojo.html Cycles:165 Average:5700.81 Median:5915.67 stddev:671.01 (11.3%) stddev-sans-first:645.84 08:00:40 INFO - PROCESS | 24652 | Values: 3288.9 3301.1 3313.2 3323.5 3334.7 5767.8 5839.0 5845.4 5852.0 5863.4 5747.6 5797.6 5799.3 5812.1 5826.7 5225.6 5239.9 5251.2 5286.8 5301.3 5047.3 5056.2 5136.4 5155.4 5251.9 5159.6 5171.2 5184.3 5222.4 5281.8 5255.8 5262.3 5271.6 5272.8 5289.4 4932.2 4937.9 4962.2 5175.2 5176.4 5088.8 5601.5 5640.6 5644.6 5672.9 6014.7 6053.8 6068.9 6083.1 6097.2 5941.8 6143.4 6145.4 6148.0 6163.9 5712.0 5763.1 5764.7 5830.1 5871.5 6349.3 6372.4 6380.1 6389.5 6400.3 5898.7 6050.2 6114.9 6116.5 6119.3 6116.6 6133.8 6140.8 6220.6 6221.2 6119.0 6182.2 6194.0 6201.6 6206.0 5901.0 6201.0 6213.3 6228.1 6229.7 4558.5 4596.8 4600.5 4638.2 4674.3 4105.3 4109.3 4132.9 4155.4 4161.1 5706.9 5758.7 5799.2 5801.7 5814.8 6073.3 6108.2 6132.0 6164.1 6181.8 5826.2 5839.8 5840.0 5863.4 5868.5 5184.6 5283.3 5289.9 5296.2 5311.9 6246.3 6250.4 6260.2 6421.1 6424.0 6196.0 6199.9 6205.6 6209.8 6211.0 6140.5 6351.6 6374.8 6382.6 6401.8 5985.3 5999.0 6009.9 6088.3 6129.8 6152.9 6159.1 6176.7 6191.9 6197.8 5814.6 6009.8 6014.9 6030.1 6043.6 5988.0 6023.2 6030.0 6116.8 6141.8 6030.9 6060.9 6071.3 6077.7 6113.0 5865.1 6048.8 6101.5 6125.7 6138.7 5739.6 5758.4 5817.1 5915.7 5943.6 08:00:40 INFO - PROCESS | 24652 | 08:00:40 INFO - PROCESS | 24652 | [#1] ext.html Cycles:180 Average:63471.48 Median:44438.72 stddev:125331.15 (282.0%) stddev-sans-first:125593.81 08:00:40 INFO - PROCESS | 24652 | Values: 591.7 647.5 654.1 673.2 683.4 40919.8 46292.1 46592.0 46694.5 46729.8 47196.0 47733.0 47750.0 47793.0 47920.0 8975.8 9057.0 9105.0 9109.5 9110.3 9112.7 9192.8 9202.5 9203.2 9218.3 9196.9 9224.5 9229.0 9250.9 9259.8 9164.9 9188.0 9192.9 9209.2 9219.4 9009.2 9089.2 9114.5 9130.8 9172.9 44265.6 44547.1 44695.6 44741.6 44899.6 3826.6 4159.0 4165.8 4456.8 4753.3 35163.3 35216.6 35617.0 35931.5 37015.8 4266.9 4319.2 4327.1 4357.6 4403.0 365327.0 367621.0 367903.0 369275.0 370692.0 66531.7 66893.0 67019.3 67037.7 67223.3 40379.4 42410.8 43217.8 43242.8 43309.0 18706.6 18952.7 18960.0 18967.2 18993.6 14303.2 14366.1 14378.1 14378.8 14392.3 21220.8 21412.5 21582.4 21597.7 21805.9 7435.9 7797.5 7896.2 7951.1 7959.8 1022.2 1083.4 1105.2 1132.3 1155.9 33792.3 34102.7 34203.0 34211.1 34422.8 1141.3 1154.5 1165.1 1167.0 1180.8 18142.7 18228.0 18266.6 18270.6 18418.8 607833.0 612178.0 619449.0 620619.0 621316.0 65151.0 65610.7 65645.0 65719.7 66020.7 1407.3 1436.0 1465.6 1468.9 1477.3 32240.2 33249.5 33566.0 33599.2 33660.2 58150.1 58432.4 58773.4 58791.7 58846.0 391087.0 391097.0 391153.0 392427.0 392532.0 31625.5 31722.7 31745.7 31980.8 32034.8 51840.7 52299.0 52623.0 52886.7 52939.7 44330.3 44959.3 45165.0 46733.5 49624.0 46272.0 46515.0 46667.0 47303.3 47409.8 45160.5 45436.8 46046.0 46179.8 46328.8 39788.4 39996.6 40546.8 40874.0 40896.0 30618.4 30976.8 31098.8 31135.2 31258.0 08:00:40 INFO - PROCESS | 24652 | 08:00:40 INFO - PROCESS | 24652 | [#2] jquery.html Cycles:180 Average:32265.77 Median:23137.84 stddev:93049.21 (402.2%) stddev-sans-first:93279.46 08:00:40 INFO - PROCESS | 24652 | Values: 396.2 402.1 402.9 407.4 423.2 19334.3 20729.4 21220.4 21234.7 21457.4 13115.9 13415.4 19569.8 21102.3 21346.0 5444.1 5518.9 5520.3 5594.9 5599.7 5344.6 5458.0 5458.2 5461.2 5495.5 5355.4 5521.4 5561.8 5588.7 5596.1 5430.1 5511.3 5551.6 5590.5 5591.0 5242.7 5399.3 5408.9 5413.1 5413.5 24671.9 24882.5 24924.6 25516.2 25694.2 2541.2 2614.8 2641.2 2703.4 3074.9 10383.7 10661.5 10775.5 10967.1 11347.6 2005.2 2034.0 2038.2 2046.2 2064.3 77395.0 90074.5 91250.0 92433.0 92758.0 11353.9 11373.5 11449.7 11637.1 11775.6 16318.4 16339.2 16344.6 16354.0 16378.2 8590.2 8807.4 8813.2 8829.4 8912.8 8565.4 8595.3 8646.5 8741.2 8774.6 4859.5 4892.6 4948.7 4960.1 5047.9 2010.3 2028.0 2071.7 2072.3 2084.2 935.7 1074.0 1092.5 1106.1 1112.0 20566.0 21344.1 21424.2 21569.8 21603.8 1040.7 1046.2 1086.0 1110.0 1160.7 11248.4 11527.3 11739.1 11822.5 11852.1 546757.0 551877.0 557589.0 582770.0 583232.0 95818.5 96013.5 99533.5 100045.0 100250.0 1056.2 1066.2 1108.8 1109.2 1110.5 18452.7 18635.7 19059.3 19213.4 19445.4 46040.0 46232.1 46721.0 47077.5 47429.0 66346.0 66548.0 68522.3 69289.3 70977.6 7969.9 8444.6 8794.8 8810.4 9000.2 13521.2 13726.9 13767.2 13977.6 14023.9 12199.7 12622.7 12664.2 12665.4 12729.7 11851.8 12036.2 12335.0 12413.4 12593.5 12495.7 12558.2 12612.6 12641.2 12885.4 8021.6 8194.6 8212.8 8389.9 8478.0 12062.5 12070.2 12310.0 12474.4 12793.2 08:00:40 INFO - PROCESS | 24652 | 08:00:40 INFO - PROCESS | 24652 | [#3] mootools.html Cycles:180 Average:6030.98 Median:2481.65 stddev:3414.13 (137.6%) stddev-sans-first:3407.49 08:00:40 INFO - PROCESS | 24652 | Values: 1602.8 1607.5 1838.4 1897.2 1902.4 8114.9 8548.7 8808.8 9165.2 9175.0 8873.8 9155.9 9226.9 9236.9 9238.3 2367.2 2388.8 2391.5 2392.2 2404.0 2398.2 2432.4 2478.1 2480.8 2484.6 2470.8 2478.7 2486.9 2501.6 2501.7 2403.1 2404.9 2411.1 2412.1 2433.5 2413.7 2417.5 2419.0 2419.8 2440.1 9241.2 9263.5 9271.9 9278.8 9364.7 5365.3 5449.5 5487.0 5493.6 5500.3 3299.2 3396.8 3433.5 3438.4 3449.4 1174.1 1201.1 1211.5 1221.0 1248.2 12700.0 12717.6 12780.9 12785.5 12850.3 4454.0 4583.3 4710.8 4720.4 4726.7 10764.8 10800.8 10860.6 10891.9 10920.9 5423.1 5479.3 5483.9 5488.7 5492.8 4503.1 4820.0 4904.2 4962.2 5094.9 4141.3 4145.5 4198.7 4211.0 4215.0 1244.5 1271.5 1277.4 1284.0 1287.1 1065.2 1073.0 1085.5 1090.3 1104.1 6162.1 6195.8 6347.2 6433.6 6434.2 451.5 451.7 461.0 467.8 468.0 4359.8 4394.8 4474.4 4511.6 4599.2 11179.7 11486.1 11524.3 11574.4 11592.6 10409.3 10817.6 11454.7 11507.6 11508.7 8360.2 8590.5 8610.7 8613.4 8614.1 6103.0 6222.2 6225.2 6337.1 6462.3 9953.0 10003.2 10080.8 10082.0 10094.2 10058.7 10149.2 10243.1 10276.2 10356.7 7375.2 8167.3 8220.5 8295.6 8678.2 8698.3 8914.7 8956.1 8982.9 8989.6 8033.1 8052.1 8061.3 8238.3 8390.1 7889.6 7928.6 8060.4 8082.3 8094.1 7271.0 7376.4 7381.1 7443.6 7450.6 5465.2 5547.9 5670.8 5672.0 5745.5 5484.6 5499.6 5604.6 5721.5 5802.9 08:00:40 INFO - PROCESS | 24652 | 08:00:40 INFO - PROCESS | 24652 | [#4] prototype.html Cycles:180 Average:4903.17 Median:5477.66 stddev:1429.05 (26.1%) stddev-sans-first:1390.90 08:00:40 INFO - PROCESS | 24652 | Values: 312.8 322.2 327.2 333.6 342.1 5609.3 5710.6 5810.9 5836.6 5852.7 5670.3 5690.3 5720.5 5725.0 5742.1 4460.3 4476.5 4479.6 4481.3 4531.5 4419.6 4461.7 4466.0 4480.3 4486.9 4411.1 4425.9 4426.3 4435.0 4440.5 4480.3 4497.8 4500.0 4501.8 4510.3 3761.8 3860.7 3881.5 3885.2 3903.4 5597.7 5611.3 5676.8 5690.4 5706.9 5061.2 5158.9 5162.8 5169.8 5186.3 6016.5 6030.2 6031.5 6055.8 6084.7 4262.1 4263.9 4292.6 4308.4 4308.4 6140.9 6282.1 6357.9 6378.3 6380.9 4407.9 4408.4 4410.1 4439.6 4442.2 4490.6 4495.7 4496.5 4499.8 4504.2 5005.6 5132.7 5165.1 5187.7 5213.8 5878.6 6032.0 6040.2 6059.3 6090.5 1512.4 1521.8 1532.2 1536.5 1541.5 916.2 950.2 969.9 982.4 990.7 5156.7 5182.2 5198.8 5199.2 5224.2 5446.9 5454.4 5476.8 5510.1 5588.6 5043.7 5257.9 5295.4 5300.5 5317.9 2968.6 2977.6 2980.5 2982.9 2984.9 5537.8 5545.4 5696.5 5715.2 5758.8 5226.6 5533.8 5541.7 5548.5 5562.3 5617.5 5647.7 5648.9 5658.5 5675.3 5140.4 5435.6 5478.5 5490.7 5498.5 5417.4 5424.6 5436.8 5458.5 5462.8 5627.4 5639.9 5673.3 5675.7 5718.7 4007.6 4034.5 4093.0 4414.7 4416.5 6070.0 6157.4 6195.8 6221.9 6235.3 6017.2 6047.7 6080.6 6088.8 6107.3 6035.8 6040.0 6047.8 6067.3 6140.3 5910.7 6065.1 6124.2 6138.5 6144.8 6175.2 6187.3 6211.8 6223.5 6226.2 5817.9 5950.6 6020.6 6032.6 6037.9 08:00:40 INFO - PROCESS | 24652 | 08:00:40 INFO - PROCESS | 24652 | [#5] yui.html Cycles:180 Average:21827.01 Median:4044.76 stddev:31099.11 (768.9%) stddev-sans-first:31146.31 08:00:40 INFO - PROCESS | 24652 | Values: 808.5 854.9 856.6 872.9 885.8 16974.8 17528.5 17628.1 17788.6 17913.0 16636.5 16639.3 16806.1 16848.6 16891.6 887.7 913.7 922.5 923.3 925.3 891.1 893.2 898.3 898.7 900.6 959.8 960.9 962.2 962.5 963.8 946.8 952.3 952.3 953.7 956.5 695.8 696.3 696.7 697.1 700.1 15711.2 15779.7 15923.8 15926.7 15932.9 13889.4 14040.8 14323.1 14325.3 14527.9 11471.8 11508.7 11717.7 11981.4 12432.3 3987.8 4101.7 4151.7 4221.8 4267.6 59019.4 67672.3 84475.6 86002.5 87018.0 12231.9 12567.8 12697.6 12730.9 12901.6 22609.9 22767.5 22844.7 22896.0 23027.3 9136.9 9267.6 9289.3 9389.8 9415.6 4906.1 4998.3 5017.6 5047.7 5073.3 3553.6 3712.3 3717.0 3725.8 3729.3 639.2 648.8 658.3 658.5 673.6 802.9 808.2 812.5 861.3 867.4 10207.7 10669.7 11096.8 11109.9 11443.8 707.4 745.5 765.1 804.5 812.3 5363.6 5497.2 5513.4 5596.7 5621.1 78168.0 95065.0 131056.0 135976.0 137173.3 86152.6 88449.0 93773.0 116617.0 121830.4 82837.0 83510.0 93648.0 94319.0 95265.0 10629.4 10742.1 10755.4 11038.8 11073.8 54897.7 55009.0 55970.0 56209.4 56312.7 73423.3 81740.6 81785.6 81840.6 82303.6 13992.7 14023.2 14128.9 14174.6 14277.2 15133.8 15209.4 15252.0 15339.5 15355.5 14046.8 14094.6 14126.3 14224.0 14397.0 14948.6 15758.4 16004.8 16163.9 16320.9 13667.3 14293.3 14407.9 14873.0 14914.6 11262.3 11306.2 11869.9 12148.5 12169.4 10906.8 12017.6 12320.7 12481.6 12582.5 08:00:40 INFO - PROCESS | 24652 | -------- Summary: end -------- 08:00:40 INFO - PROCESS | 24652 | 08:00:41 INFO - TEST-INFO | 24652: exit 0 08:00:41 INFO - TEST-OK | dromaeo_css | took 1110871ms 08:00:41 INFO - TEST-START | kraken 08:00:41 INFO - operating with platform_type : linux_ 08:00:41 INFO - Initialising browser for kraken test... 08:00:41 INFO - TEST-INFO | started process 24916 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpitQcbg/profile http://localhost:47254/getInfo.html) 08:00:45 INFO - PROCESS | 24916 | __metrics Screen width/height:1600/1200 08:00:45 INFO - PROCESS | 24916 | colorDepth:24 08:00:45 INFO - PROCESS | 24916 | Browser inner width/height: 1024/697 08:00:45 INFO - PROCESS | 24916 | __metrics 08:00:46 ERROR - PROCESS | 24916 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 08:00:47 INFO - TEST-INFO | 24916: exit 0 08:00:47 INFO - Browser initialized. 08:00:47 INFO - Running cycle 1/1 for kraken test... 08:00:47 INFO - TEST-INFO | started process 25045 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpitQcbg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:00:58 INFO - PROCESS | 25045 | RSS: Main: 152227840 08:00:58 INFO - PROCESS | 25045 | 08:01:01 INFO - PROCESS | 25045 | Cycle 1(1): loaded http://localhost:47254/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47254/tests/kraken/driver.html?testName=audio-beat-detection) 08:01:02 INFO - PROCESS | 25045 | RSS: Main: 157958144 08:01:02 INFO - PROCESS | 25045 | 08:01:05 INFO - PROCESS | 25045 | Cycle 1(1): loaded http://localhost:47254/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47254/tests/kraken/driver.html?testName=audio-dft) 08:01:05 INFO - PROCESS | 25045 | RSS: Main: 157212672 08:01:05 INFO - PROCESS | 25045 | 08:01:08 INFO - PROCESS | 25045 | Cycle 1(1): loaded http://localhost:47254/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47254/tests/kraken/driver.html?testName=audio-fft) 08:01:09 INFO - PROCESS | 25045 | RSS: Main: 156606464 08:01:09 INFO - PROCESS | 25045 | 08:01:11 INFO - PROCESS | 25045 | Cycle 1(1): loaded http://localhost:47254/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47254/tests/kraken/driver.html?testName=audio-oscillator) 08:01:11 INFO - PROCESS | 25045 | RSS: Main: 156254208 08:01:11 INFO - PROCESS | 25045 | 08:01:13 INFO - PROCESS | 25045 | Cycle 1(1): loaded http://localhost:47254/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47254/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:01:14 INFO - PROCESS | 25045 | RSS: Main: 156528640 08:01:14 INFO - PROCESS | 25045 | 08:01:17 INFO - PROCESS | 25045 | Cycle 1(1): loaded http://localhost:47254/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47254/tests/kraken/driver.html?testName=imaging-darkroom) 08:01:18 INFO - PROCESS | 25045 | RSS: Main: 156291072 08:01:18 INFO - PROCESS | 25045 | 08:01:21 INFO - PROCESS | 25045 | Cycle 1(1): loaded http://localhost:47254/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47254/tests/kraken/driver.html?testName=imaging-desaturate) 08:01:22 INFO - PROCESS | 25045 | RSS: Main: 155369472 08:01:22 INFO - PROCESS | 25045 | 08:01:25 INFO - PROCESS | 25045 | Cycle 1(1): loaded http://localhost:47254/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47254/tests/kraken/driver.html?testName=json-parse-financial) 08:01:25 INFO - PROCESS | 25045 | RSS: Main: 156672000 08:01:25 INFO - PROCESS | 25045 | 08:01:27 INFO - PROCESS | 25045 | Cycle 1(1): loaded http://localhost:47254/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47254/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:01:27 INFO - PROCESS | 25045 | RSS: Main: 156729344 08:01:27 INFO - PROCESS | 25045 | 08:01:29 INFO - PROCESS | 25045 | Cycle 1(1): loaded http://localhost:47254/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47254/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:01:30 INFO - PROCESS | 25045 | RSS: Main: 156614656 08:01:30 INFO - PROCESS | 25045 | 08:01:32 INFO - PROCESS | 25045 | Cycle 1(1): loaded http://localhost:47254/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47254/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:01:33 INFO - PROCESS | 25045 | RSS: Main: 157057024 08:01:33 INFO - PROCESS | 25045 | 08:01:35 INFO - PROCESS | 25045 | Cycle 1(1): loaded http://localhost:47254/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47254/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:01:36 INFO - PROCESS | 25045 | RSS: Main: 157442048 08:01:36 INFO - PROCESS | 25045 | 08:01:38 INFO - PROCESS | 25045 | Cycle 1(1): loaded http://localhost:47254/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47254/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:01:39 INFO - PROCESS | 25045 | RSS: Main: 157331456 08:01:39 INFO - PROCESS | 25045 | 08:01:41 INFO - PROCESS | 25045 | Cycle 1(1): loaded http://localhost:47254/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47254/tests/kraken/driver.html?testName=ai-astar) 08:01:41 INFO - PROCESS | 25045 | RSS: Main: 158683136 08:01:41 INFO - PROCESS | 25045 | 08:01:41 INFO - PROCESS | 25045 | __start_tp_report 08:01:41 INFO - PROCESS | 25045 | _x_x_mozilla_page_load 08:01:41 INFO - PROCESS | 25045 | _x_x_mozilla_page_load_details 08:01:41 INFO - PROCESS | 25045 | |i|pagename|runs| 08:01:41 INFO - PROCESS | 25045 | |0;ai-astar;105;113;105;111;113;113;112;111;111;111 08:01:41 INFO - PROCESS | 25045 | |1;audio-beat-detection;148;119;142;186;119;142;148;119;184;121 08:01:41 INFO - PROCESS | 25045 | |2;audio-dft;161;161;164;164;162;161;161;163;161;163 08:01:41 INFO - PROCESS | 25045 | |3;audio-fft;76;76;75;167;75;76;74;75;171;76 08:01:41 INFO - PROCESS | 25045 | |4;audio-oscillator;84;83;146;83;84;83;139;83;83;143 08:01:41 INFO - PROCESS | 25045 | |5;imaging-gaussian-blur;118;118;118;117;117;118;117;117;119;118 08:01:41 INFO - PROCESS | 25045 | |6;imaging-darkroom;147;147;147;147;146;148;148;148;149;148 08:01:41 INFO - PROCESS | 25045 | |7;imaging-desaturate;96;95;96;94;95;96;95;96;99;95 08:01:41 INFO - PROCESS | 25045 | |8;json-parse-financial;53;58;51;51;50;51;54;52;51;58 08:01:41 INFO - PROCESS | 25045 | |9;json-stringify-tinderbox;63;59;59;59;60;59;59;60;60;61 08:01:41 INFO - PROCESS | 25045 | |10;stanford-crypto-aes;79;82;73;82;74;73;82;83;79;81 08:01:41 INFO - PROCESS | 25045 | |11;stanford-crypto-ccm;128;127;125;128;127;117;120;118;159;122 08:01:41 INFO - PROCESS | 25045 | |12;stanford-crypto-pbkdf2;154;151;153;151;153;152;155;151;155;150 08:01:41 INFO - PROCESS | 25045 | |13;stanford-crypto-sha256-iterative;65;61;67;64;65;64;63;64;62;61 08:01:41 INFO - PROCESS | 25045 | __end_tp_report 08:01:41 INFO - PROCESS | 25045 | __start_cc_report 08:01:41 INFO - PROCESS | 25045 | _x_x_mozilla_cycle_collect,860 08:01:41 INFO - PROCESS | 25045 | __end_cc_report 08:01:41 INFO - PROCESS | 25045 | __startTimestamp1472828501353__endTimestamp 08:01:41 INFO - PROCESS | 25045 | 08:01:41 INFO - PROCESS | 25045 | ------- Summary: start ------- 08:01:41 INFO - PROCESS | 25045 | Number of tests: 14 08:01:41 INFO - PROCESS | 25045 | 08:01:41 INFO - PROCESS | 25045 | [#0] ai-astar Cycles:10 Average:110.50 Median:111.50 stddev:3.03 (2.7%) stddev-sans-first:2.47 08:01:41 INFO - PROCESS | 25045 | Values: 105.0 113.0 105.0 111.0 113.0 113.0 112.0 111.0 111.0 111.0 08:01:41 INFO - PROCESS | 25045 | 08:01:41 INFO - PROCESS | 25045 | [#1] audio-beat-detection Cycles:10 Average:142.80 Median:145.00 stddev:25.37 (17.5%) stddev-sans-first:26.84 08:01:41 INFO - PROCESS | 25045 | Values: 148.0 119.0 142.0 186.0 119.0 142.0 148.0 119.0 184.0 121.0 08:01:41 INFO - PROCESS | 25045 | 08:01:41 INFO - PROCESS | 25045 | [#2] audio-dft Cycles:10 Average:162.10 Median:162.50 stddev:1.29 (0.8%) stddev-sans-first:1.30 08:01:41 INFO - PROCESS | 25045 | Values: 161.0 161.0 164.0 164.0 162.0 161.0 161.0 163.0 161.0 163.0 08:01:41 INFO - PROCESS | 25045 | 08:01:41 INFO - PROCESS | 25045 | [#3] audio-fft Cycles:10 Average:94.10 Median:75.50 stddev:39.49 (52.3%) stddev-sans-first:41.34 08:01:41 INFO - PROCESS | 25045 | Values: 76.0 76.0 75.0 167.0 75.0 76.0 74.0 75.0 171.0 76.0 08:01:41 INFO - PROCESS | 25045 | 08:01:41 INFO - PROCESS | 25045 | [#4] audio-oscillator Cycles:10 Average:101.10 Median:83.00 stddev:28.73 (34.6%) stddev-sans-first:29.80 08:01:41 INFO - PROCESS | 25045 | Values: 84.0 83.0 146.0 83.0 84.0 83.0 139.0 83.0 83.0 143.0 08:01:41 INFO - PROCESS | 25045 | 08:01:41 INFO - PROCESS | 25045 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 08:01:41 INFO - PROCESS | 25045 | Values: 118.0 118.0 118.0 117.0 117.0 118.0 117.0 117.0 119.0 118.0 08:01:41 INFO - PROCESS | 25045 | 08:01:41 INFO - PROCESS | 25045 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:148.00 stddev:0.85 (0.6%) stddev-sans-first:0.88 08:01:41 INFO - PROCESS | 25045 | Values: 147.0 147.0 147.0 147.0 146.0 148.0 148.0 148.0 149.0 148.0 08:01:41 INFO - PROCESS | 25045 | 08:01:41 INFO - PROCESS | 25045 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:1.34 (1.4%) stddev-sans-first:1.41 08:01:41 INFO - PROCESS | 25045 | Values: 96.0 95.0 96.0 94.0 95.0 96.0 95.0 96.0 99.0 95.0 08:01:41 INFO - PROCESS | 25045 | 08:01:41 INFO - PROCESS | 25045 | [#8] json-parse-financial Cycles:10 Average:52.90 Median:52.50 stddev:2.92 (5.6%) stddev-sans-first:3.10 08:01:41 INFO - PROCESS | 25045 | Values: 53.0 58.0 51.0 51.0 50.0 51.0 54.0 52.0 51.0 58.0 08:01:41 INFO - PROCESS | 25045 | 08:01:41 INFO - PROCESS | 25045 | [#9] json-stringify-tinderbox Cycles:10 Average:59.90 Median:60.00 stddev:1.29 (2.1%) stddev-sans-first:0.73 08:01:41 INFO - PROCESS | 25045 | Values: 63.0 59.0 59.0 59.0 60.0 59.0 59.0 60.0 60.0 61.0 08:01:41 INFO - PROCESS | 25045 | 08:01:41 INFO - PROCESS | 25045 | [#10] stanford-crypto-aes Cycles:10 Average:78.80 Median:81.50 stddev:3.99 (4.9%) stddev-sans-first:4.24 08:01:41 INFO - PROCESS | 25045 | Values: 79.0 82.0 73.0 82.0 74.0 73.0 82.0 83.0 79.0 81.0 08:01:41 INFO - PROCESS | 25045 | 08:01:41 INFO - PROCESS | 25045 | [#11] stanford-crypto-ccm Cycles:10 Average:127.10 Median:127.00 stddev:11.95 (9.4%) stddev-sans-first:12.67 08:01:41 INFO - PROCESS | 25045 | Values: 128.0 127.0 125.0 128.0 127.0 117.0 120.0 118.0 159.0 122.0 08:01:41 INFO - PROCESS | 25045 | 08:01:41 INFO - PROCESS | 25045 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.50 Median:153.00 stddev:1.78 (1.2%) stddev-sans-first:1.80 08:01:41 INFO - PROCESS | 25045 | Values: 154.0 151.0 153.0 151.0 153.0 152.0 155.0 151.0 155.0 150.0 08:01:41 INFO - PROCESS | 25045 | 08:01:41 INFO - PROCESS | 25045 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.60 Median:64.00 stddev:1.90 (3.0%) stddev-sans-first:1.94 08:01:41 INFO - PROCESS | 25045 | Values: 65.0 61.0 67.0 64.0 65.0 64.0 63.0 64.0 62.0 61.0 08:01:41 INFO - PROCESS | 25045 | -------- Summary: end -------- 08:01:41 INFO - PROCESS | 25045 | 08:01:42 INFO - TEST-INFO | 25045: exit 0 08:01:42 INFO - TEST-OK | kraken | took 60956ms 08:01:42 INFO - SUITE-END | took 1171s 08:01:42 INFO - Completed test suite (00:19:32) 08:01:42 INFO - javascript benchmark 08:01:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7674.9920225635715, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3288.8684452621897, 3301.0591981285324, 3313.155145437913, 3323.534705141279, 3334.733221342293, 5767.8269651910405, 5839.0, 5845.357010728827, 5852.034414321637, 5863.442972917576, 5747.626404283718, 5797.594168408213, 5799.333076696181, 5812.1281807728865, 5826.679532625714, 5225.634205605609, 5239.921401178975, 5251.159814429692, 5286.762095705683, 5301.257823904656, 5047.293378926953, 5056.241563765446, 5136.383633963929, 5155.432902380735, 5251.868703282429, 5159.5614372778355, 5171.17261238202, 5184.326037615105, 5222.425533191365, 5281.815136470224, 5255.816046438375, 5262.315898933152, 5271.604629652791, 5272.789088436458, 5289.44460831611, 4932.235503496964, 4937.851864444073, 4962.1812400953795, 5175.249588809639, 5176.378834539879, 5088.821891233789, 5601.467860553241, 5640.633358831663, 5644.6330988486025, 5672.886542269172, 6014.729337179838, 6053.788117415913, 6068.878622427526, 6083.117947897575, 6097.237845269341, 5941.762329506814, 6143.354947730513, 6145.446909778141, 6148.047052706837, 6163.938360616381, 5711.971440142773, 5763.106718458645, 5764.654120752726, 5830.067189249699, 5871.4715675589405, 6349.301576826545, 6372.394622510854, 6380.074889141141, 6389.520785941073, 6400.327965563642, 5898.734556944948, 6050.213472248667, 6114.938850611526, 6116.480099191618, 6119.265688117365, 6116.602420842631, 6133.84665383369, 6140.846478838065, 6220.595661282002, 6221.160143380585, 6118.969405152946, 6182.227221597301, 6193.977993631001, 6201.56589038772, 6206.0, 5900.970495147497, 6201.0, 6213.347598502092, 6228.096925945712, 6229.719662615103, 4558.544145585482, 4596.839110631112, 4600.470945841204, 4638.234691275901, 4674.252119660906, 4105.322621767435, 4109.3425051991535, 4132.884121287236, 4155.3766934959995, 4161.146964872194, 5706.885862282731, 5758.74085666146, 5799.217105690762, 5801.6809075500405, 5814.825555233349, 6073.331933487401, 6108.175396321529, 6131.96934015327, 6164.106204600397, 6181.8454538636, 5826.1552074948895, 5839.766409343579, 5840.036393994943, 5863.442972917651, 5868.530517558585, 5184.585233181337, 5283.313169287968, 5289.894202116013, 5296.179092240709, 5311.893762124736, 6246.344133865879, 6250.374962503804, 6260.217472815898, 6421.068945003042, 6424.036394540763, 6195.96902015478, 6199.938000620116, 6205.627662340274, 6209.813705588839, 6210.968945155245, 6140.508759299156, 6351.587146835441, 6374.808755737336, 6382.5532212744665, 6401.839954001187, 5985.25184351956, 5999.010163323002, 6009.939900600938, 6088.299845517822, 6129.84675383119, 6152.907706384318, 6159.071045074292, 6176.6911654418, 6191.907121393093, 6197.752089916353, 5814.622049566765, 6009.798040391852, 6014.879702405839, 6030.095485677008, 6043.607165534227, 5988.0, 6023.1567580537885, 6029.969850150721, 6116.792316687851, 6141.815745527641, 6030.939690603038, 6060.939390606038, 6071.332153463204, 6077.6961151943115, 6113.0, 5865.14955331466, 6048.818535443944, 6101.542384321105, 6125.724342404514, 6138.693065346804, 5739.5695322850115, 5758.395368486416, 5817.0983497557945, 5915.674637894957, 5943.64338139713], "value": 5654.200164676599, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [591.7130191856951, 647.4593714248603, 654.1496055128332, 673.1551902362535, 683.4498228925713, 40919.79540102299, 46292.07415851681, 46592.0, 46694.533054669446, 46729.76635116824, 47196.0, 47733.0, 47750.0, 47793.0, 47920.0, 8975.82048359034, 9057.049009853969, 9105.0, 9109.453432794053, 9110.316726245524, 9112.681056163035, 9192.770180745469, 9202.539873006357, 9203.217726493256, 9218.262538996863, 9196.908030919672, 9224.492652904088, 9229.0, 9250.86123708145, 9259.814803703955, 9164.8625270621, 9187.954060229657, 9192.862107068366, 9209.171174594285, 9219.35464517484, 9009.189172974398, 9089.227415669677, 9114.498702571356, 9130.817383652357, 9172.908270917338, 44265.55734442679, 44547.10905781898, 44695.55304446979, 44741.55258447406, 44899.55100448986, 3826.617338266179, 4159.043420013414, 4165.812538435777, 4456.799444024994, 4753.287006948951, 35163.29673406543, 35216.647833521594, 35617.0, 35931.4610280846, 37015.81492092549, 4266.850660226908, 4319.222539942809, 4327.112941846945, 4357.629601483878, 4403.0, 365326.9999999973, 367621.0, 367903.0, 369275.0, 370692.0, 66531.66734166298, 66893.0, 67019.32980670228, 67037.66481167563, 67223.32776672268, 40379.394309085386, 42410.78794606069, 43217.783911080245, 43242.783786080865, 43309.0, 18706.625867482573, 18952.715709264372, 18960.0, 18967.241310347432, 18993.62012759737, 14303.21332326732, 14366.066205696805, 14378.065425747292, 14378.784318235235, 14392.280385980659, 21220.78779212219, 21412.464688382915, 21582.35252942414, 21597.67603485949, 21805.890970545046, 7435.925640743631, 7797.532148071134, 7896.20981928666, 7951.051992261817, 7959.761207163794, 1022.1822541966397, 1083.4366129612558, 1105.237386203517, 1132.326265871805, 1155.942202889852, 33792.32415351679, 34102.65897341044, 34203.0, 34211.144721381665, 34422.82788586041, 1141.3323205924462, 1154.451461242701, 1165.0737663557493, 1167.0430247197216, 1180.7874582575218, 18142.727859082126, 18228.0, 18266.634667306844, 18270.63458730818, 18418.815811841978, 607833.0, 612178.0, 619449.0, 620619.0, 621316.0, 65151.0, 65610.67194664091, 65645.0, 65719.67140164365, 66020.66989665022, 1407.3385508810843, 1435.9712805743827, 1465.5969608357573, 1468.9045212061396, 1477.2613693153423, 32240.19399514937, 33249.501257480675, 33566.0, 33599.16002099967, 33660.158496037795, 58150.12774808297, 58432.4156758427, 58773.412265876796, 58791.70604146952, 58846.0, 391087.0, 391097.0, 391153.0, 392427.0, 392532.0, 31625.468016009265, 31722.682773172895, 31745.682543174273, 31980.840095799373, 32034.839825801653, 51840.74079629578, 52299.0, 52623.0, 52886.73556632346, 52939.73530132325, 44330.335044975, 44959.32561011653, 45165.0, 46733.532664674276, 49624.0, 46272.0, 46515.0, 46667.0, 47303.29045064258, 47409.7629511864, 45160.54839451564, 45436.77281613571, 46046.0, 46179.76910115428, 46328.768356158005, 39788.403173953, 39996.60003399929, 40546.797266013484, 40874.007718301924, 40896.0, 30618.387632247675, 30976.84511577428, 31098.844505777328, 31135.221619459695, 31258.0], "value": 21516.940852931177, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [396.1976996581923, 402.1293898709293, 402.89726119839446, 407.4173931278272, 423.19803971474056, 19334.32329868455, 20729.378118656463, 21220.363389098315, 21234.681479777795, 21457.356279311607, 13115.934420327885, 13415.396307166176, 19569.804301956978, 21102.261420850275, 21346.03942822573, 5444.128939369702, 5518.944810551883, 5520.254765606632, 5594.8601284968, 5599.692016939067, 5344.625876188668, 5458.044842152627, 5458.153986132136, 5461.2354270402175, 5495.477929596682, 5355.357357117132, 5521.365043020064, 5561.805336813212, 5588.720563971785, 5596.132599447093, 5430.104032834578, 5511.311086114236, 5551.555875529948, 5590.524805391527, 5590.972045139789, 5242.711650859239, 5399.271098401705, 5408.945910540923, 5413.106837371829, 5413.485718856702, 24671.876640616683, 24882.502349952898, 24924.626130608056, 25516.234512964642, 25694.229173124837, 2541.1507285295033, 2614.843109413422, 2641.220839852248, 2703.4322792213657, 3074.8616312266004, 10383.688489345332, 10661.466926653713, 10775.515101820436, 10967.122630189646, 11347.581552305961, 2005.177877070394, 2034.013503450825, 2038.194913009353, 2046.2224354745251, 2064.3394113883564, 77395.0, 90074.54962725144, 91250.0, 92433.0, 92758.0, 11353.886461135447, 11373.545058197746, 11449.713757156138, 11637.127215458875, 11775.646730597924, 16318.428854990017, 16339.18304084791, 16344.591385215464, 16354.0, 16378.181090945405, 8590.226879580743, 8807.383483156245, 8813.162749538784, 8829.381943264038, 8912.777180570538, 8565.400421970528, 8595.269402100766, 8646.481211127353, 8741.213290803858, 8774.60514276859, 4859.538343857328, 4892.633052521075, 4948.727819969864, 4960.131976904027, 5047.873803154877, 2010.3064442767222, 2027.9797202028085, 2071.7099606055162, 2072.3161356752234, 2084.1767501836994, 935.6538080910107, 1073.951672174754, 1092.4537731134433, 1106.0755076926143, 1111.988090837334, 20566.0, 21344.14623415046, 21424.15847898422, 21569.78430215709, 21603.811790351683, 1040.7450174707244, 1046.210111365914, 1085.9837102443469, 1110.0453609895483, 1160.6692092753694, 11248.381339026431, 11527.308361498337, 11739.11956603241, 11822.467988940347, 11852.11109166816, 546757.0, 551877.0, 557589.0, 582770.0, 583232.0, 95818.52090739501, 96013.5199324013, 99533.50233248933, 100045.0, 100250.0, 1056.1972900595604, 1066.221658189526, 1108.8281316395971, 1109.1681239070697, 1110.5169251375678, 18452.723209152144, 18635.72046419278, 19059.33292334817, 19213.423597292105, 19445.416637500897, 46040.0, 46232.075358491966, 46721.0, 47077.529224707316, 47429.0, 66346.0, 66548.0, 68522.31477685159, 69289.30710692829, 70977.64511177411, 7969.880451793112, 8444.619992100248, 8794.780130496532, 8810.383273170817, 9000.234980026771, 13521.18872867631, 13726.86273137256, 13767.242801645605, 13977.58067257984, 14023.929880350533, 12199.69500762488, 12622.684432889251, 12664.176828506117, 12665.430055647334, 12729.681757956125, 11851.822222666839, 12036.157468977088, 12335.0, 12413.44139513706, 12593.496260149857, 12495.687607809878, 12558.183718058297, 12612.621621351374, 12641.178323408949, 12885.42015609281, 8021.639026243716, 8194.631241594261, 8212.83574328522, 8389.874151887605, 8478.02502712196, 12062.45718942632, 12070.155089144027, 12310.0, 12474.376281185723, 12793.168444051107], "value": 9719.646389799733, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1602.8121613996893, 1607.4615003973668, 1838.4392760208138, 1897.1842107893601, 1902.362708492655, 8114.91885081149, 8548.70079547216, 8808.77978050549, 9165.220956218722, 9175.0, 8873.778155546115, 9155.90844091559, 9226.907730922689, 9236.8614470783, 9238.30712696547, 2367.23065003874, 2388.79695225906, 2391.5336509380677, 2392.2105705117356, 2403.9639405408934, 2398.2325655790155, 2432.3675844280438, 2478.0583378316214, 2480.8015358771254, 2484.627305904111, 2470.765277298654, 2478.7273399926084, 2486.8632225227607, 2501.6122501012374, 2501.69979602448, 2403.122860156039, 2404.89177986991, 2411.1319924827135, 2412.1195763546357, 2433.525462534789, 2413.6500207469994, 2417.504411595619, 2418.9879050604636, 2419.806415486757, 2440.133752517866, 9241.168294853496, 9263.490508022056, 9271.860922086174, 9278.814423711556, 9364.719058428258, 5365.302510673627, 5449.509544141007, 5486.972565137189, 5493.615446918718, 5500.28496295479, 3299.2411745298477, 3396.8111161093666, 3433.484977253407, 3438.449848024304, 3449.4308439107517, 1174.0666170394557, 1201.1411840533972, 1211.4669545399995, 1220.9755804883941, 1248.2073883084215, 12700.0, 12717.554885579053, 12780.936095319465, 12785.488580456771, 12850.293233872133, 4453.955460445419, 4583.312503124492, 4710.788014539354, 4720.362751028636, 4726.740029298353, 10764.78470430587, 10800.837987430195, 10860.619878304222, 10891.945540272249, 10920.890791092146, 5423.105187643994, 5479.3424789024775, 5483.945160548423, 5488.725563721798, 5492.835214943558, 4503.076869241798, 4819.975900120477, 4904.190808516626, 4962.15643340633, 5094.923576146361, 4141.316682747373, 4145.489594046058, 4198.664106871504, 4210.957890421118, 4214.978925105416, 1244.5146392906775, 1271.5295340723992, 1277.3994731348514, 1283.9743205135844, 1287.0861688201294, 1065.1585247654266, 1072.951717172729, 1085.4572713643179, 1090.2531765740493, 1104.0560320925492, 6162.106494558354, 6195.752169913243, 6347.174867267318, 6433.646149461731, 6434.227892652912, 451.5304083752926, 451.6928488627699, 461.04563553444046, 467.7965085187954, 467.9812807487662, 4359.80380882861, 4394.758288294111, 4474.440694913136, 4511.616512596401, 4599.1721490132095, 11179.66461006171, 11486.0811135109, 11524.250923689933, 11574.363410012362, 11592.594259200887, 10409.323393979366, 10817.621383251548, 11454.713632159095, 11507.597234096766, 11508.712282193012, 8360.163983601591, 8590.527520986281, 8610.741677749678, 8613.440126391764, 8614.095519970439, 6103.0405489645145, 6222.222222222223, 6225.190725205694, 6337.081123237012, 6462.289148193601, 9952.950235248778, 10003.199744020316, 10080.798384032132, 10082.04220599042, 10094.192464602667, 10058.698239052841, 10149.23880708935, 10243.07812296897, 10276.17790576767, 10356.689299321033, 7375.2256013119995, 8167.305779008851, 8220.465669731448, 8295.58522073906, 8678.175573320525, 8698.26064784475, 8914.687985920462, 8956.149165829236, 8982.86525702128, 8989.595468203815, 8033.11635720082, 8052.114267430695, 8061.2744852963515, 8238.299744521782, 8390.077091519806, 7889.605519724106, 7928.563928983961, 8060.355171586376, 8082.272595466201, 8094.069182043905, 7271.0, 7376.373008294355, 7381.077365329334, 7443.590602516913, 7450.552966822008, 5465.234867118686, 5547.861303467445, 5670.829875103588, 5672.0, 5745.482906538432, 5484.561235101262, 5499.560035197094, 5604.607677462702, 5721.456461636138, 5802.854928626649], "value": 4762.497411194479, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [312.8060602426495, 322.17844496533843, 327.2277425276349, 333.5613668026546, 342.07127648434493, 5609.298837645294, 5710.600257981943, 5810.941890581093, 5836.562257830664, 5852.707364631768, 5670.3479099903425, 5690.260266165393, 5720.484071720997, 5725.0, 5742.081266997281, 4460.33095035744, 4476.507584165739, 4479.596836284733, 4481.2523115984795, 4531.524189960056, 4419.62433193179, 4461.687681862271, 4465.955340446602, 4480.283154695249, 4486.932696009562, 4411.09572537629, 4425.889352766175, 4426.269665505204, 4435.0, 4440.511543730187, 4480.252701446439, 4497.775111244458, 4499.977500112478, 4501.774911254424, 4510.345999830006, 3761.8307176177136, 3860.7297489175767, 3881.4565960765517, 3885.2229554089295, 3903.434002069684, 5597.7201139943245, 5611.298587676541, 5676.772929082832, 5690.430956904318, 5706.942930570683, 5061.190209566452, 5158.92261616076, 5162.819301324474, 5169.793208271664, 5186.273921650972, 6016.548758843104, 6030.155778191057, 6031.531869175242, 6055.788047418363, 6084.726187321581, 4262.126264115849, 4263.936040959357, 4292.613664770186, 4308.375285583573, 4308.418363520916, 6140.877182456371, 6282.120503129566, 6357.872842543124, 6378.321105135808, 6380.872382552369, 4407.933880991788, 4408.382826404306, 4410.117976404732, 4439.556044395599, 4442.244818380883, 4490.595846373842, 4495.685302028826, 4496.505384407713, 4499.77501124949, 4504.189245935763, 5005.574526165244, 5132.717700526507, 5165.070287348313, 5187.740612969412, 5213.817516386908, 5878.617889837147, 6032.0, 6040.244969378828, 6059.272887253558, 6090.543209259324, 1512.4177191781243, 1521.8021657184718, 1532.1573134775829, 1536.523677659929, 1541.537538738374, 916.1525588830306, 950.1686024728363, 969.8836139663285, 982.381099907054, 990.6928852055742, 5156.74216289184, 5182.2485739567555, 5198.84403467889, 5199.2201169824075, 5224.216367544898, 5446.945530544723, 5454.400015998237, 5476.835694929158, 5510.1459273812625, 5588.552915766729, 5043.697378157249, 5257.921131183035, 5295.372669721253, 5300.522952934254, 5317.8936421271355, 2968.5547167924983, 2977.553366994968, 2980.4933161362187, 2982.895598654037, 2984.925376865596, 5537.8061767837935, 5545.417731138253, 5696.544276457957, 5715.228444160069, 5758.7696492140685, 5226.5818734501145, 5533.806316778893, 5541.667499950016, 5548.500634942875, 5562.3047119110115, 5617.494425501724, 5647.717614119278, 5648.943510564924, 5658.490735833712, 5675.347335056521, 5140.41213790393, 5435.619506634498, 5478.479544443271, 5490.670559766427, 5498.45015498447, 5417.42894560573, 5424.593155513273, 5436.809711660073, 5458.5087342139395, 5462.754176062166, 5627.396192085236, 5639.887202256014, 5673.290838645169, 5675.694590244184, 5718.714064296852, 4007.579204183519, 4034.4755181826176, 4093.0381360380884, 4414.735115893057, 4416.514183439884, 6069.969650151721, 6157.353477884937, 6195.783147589813, 6221.875562488815, 6235.3452887446165, 6017.217761690952, 6047.669512707197, 6080.604760690541, 6088.786892458743, 6107.328193898578, 6035.818925432244, 6039.969800150971, 6047.758089676364, 6067.302260240129, 6140.263168419819, 5910.674912879833, 6065.119812858028, 6124.234470691164, 6138.478229350377, 6144.78493252734, 6175.197224360804, 6187.288461826947, 6211.81364559064, 6223.502119830312, 6226.205821517316, 5817.883642327214, 5950.553708471795, 6020.578559500793, 6032.607880487754, 6037.94335991191], "value": 4438.694790367304, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [808.5431731071944, 854.8845905802718, 856.5631527920758, 872.9432586881852, 885.7608445719655, 16974.83025169748, 17528.47414577563, 17628.118594070278, 17788.64422711545, 17913.0, 16636.50090497284, 16639.251233694482, 16806.075665838373, 16848.578785530368, 16891.577710557212, 887.6715615222361, 913.6756451459736, 922.4695799915042, 923.3351986569659, 925.255169588481, 891.0643823984823, 893.2362829780542, 898.3397203055749, 898.6989358564889, 900.5677274908048, 959.8176346494179, 960.9087136722035, 962.1581116523042, 962.4706411473696, 963.7590602349412, 946.7775072857872, 952.3286083311249, 952.3381250031231, 953.7234202081388, 956.5121787888193, 695.8086526205284, 696.345435290825, 696.6656005117521, 697.1285892634207, 700.1248439450686, 15711.21443927799, 15779.684406311924, 15923.840761592352, 15926.681466370608, 15932.920335398365, 13889.374978126009, 14040.789388159186, 14323.14061156334, 14325.283735813167, 14527.854721452755, 11471.770564588745, 11508.654740357802, 11717.707057323634, 11981.400929953468, 12432.254064756144, 3987.7806720630356, 4101.733387329814, 4151.709380343377, 4221.810018549173, 4267.573242675739, 59019.40980590182, 67672.3232767671, 84475.5776221121, 86002.49937515621, 87018.0, 12231.938840305742, 12567.811482827765, 12697.55558555446, 12730.936345318214, 12901.612951611467, 22609.88695056547, 22767.544649106923, 22844.65733014006, 22896.0, 23027.309180724606, 9136.908630913738, 9267.582958766738, 9289.303302252223, 9389.812203755886, 9415.623375065057, 4906.067847109038, 4998.275250088716, 5017.623678224148, 5047.722375269322, 5073.340465739504, 3553.591336996227, 3712.3132220539287, 3716.9814150929074, 3725.7950812705562, 3729.272791805626, 639.2137670665107, 648.8183308673579, 658.2824721054074, 658.5159907468008, 673.5756473421714, 802.8835818806241, 808.1756608259542, 812.4962523235632, 861.2593169873903, 867.4144952157269, 10207.693769186937, 10669.679909602724, 11096.833547496793, 11109.888901111048, 11443.828342574869, 707.4305184326564, 745.5005146551823, 765.0608976582345, 804.5172896262196, 812.2811311988933, 5363.605462579757, 5497.202905578669, 5513.448655134534, 5596.748146333425, 5621.100623900156, 78168.0, 95065.0, 131056.0, 135976.0, 137173.3141334287, 86152.56923715341, 88449.0, 93773.0, 116617.0, 121830.3908480452, 82836.99999999879, 83510.0, 93648.0, 94319.0, 95265.0, 10629.427888143906, 10742.140628749838, 10755.354678719303, 11038.779224415628, 11073.778524429305, 54897.725511373785, 55009.0, 55970.0, 56209.43790562042, 56312.71843640756, 73423.26576734378, 81740.59129704314, 81785.59107204426, 81840.59079704563, 82303.58848205721, 13992.720145597235, 14023.228722419957, 14128.858711412755, 14174.645633858823, 14277.214753188675, 15133.848661513684, 15209.391624335345, 15252.0, 15339.463118790789, 15355.539333820003, 14046.78929816033, 14094.647633809236, 14126.293685315899, 14224.0, 14397.0, 14948.626284342978, 15758.448454304043, 16004.759928601314, 16163.919180404022, 16320.918395407947, 13667.316634168053, 14293.28533573338, 14407.855921440652, 14873.0, 14914.627134321729, 11262.267952583055, 11306.152038596974, 11869.940650296694, 12148.453319600463, 12169.39153042362, 10906.836397453886, 12017.63947081589, 12320.691982700504, 12481.625551233477, 12582.496700131893], "value": 8175.815598405319, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1506.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 113.0, 105.0, 111.0, 113.0, 113.0, 112.0, 111.0, 111.0, 111.0], "value": 110.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 119.0, 142.0, 186.0, 119.0, 142.0, 148.0, 119.0, 184.0, 121.0], "value": 142.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 164.0, 164.0, 162.0, 161.0, 161.0, 163.0, 161.0, 163.0], "value": 162.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 167.0, 75.0, 76.0, 74.0, 75.0, 171.0, 76.0], "value": 94.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 146.0, 83.0, 84.0, 83.0, 139.0, 83.0, 83.0, 143.0], "value": 101.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 117.0, 117.0, 118.0, 117.0, 117.0, 119.0, 118.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 147.0, 146.0, 148.0, 148.0, 148.0, 149.0, 148.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 94.0, 95.0, 96.0, 95.0, 96.0, 99.0, 95.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 58.0, 51.0, 51.0, 50.0, 51.0, 54.0, 52.0, 51.0, 58.0], "value": 52.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 59.0, 59.0, 59.0, 60.0, 59.0, 59.0, 60.0, 60.0, 61.0], "value": 59.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 82.0, 73.0, 82.0, 74.0, 73.0, 82.0, 83.0, 79.0, 81.0], "value": 78.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 127.0, 125.0, 128.0, 127.0, 117.0, 120.0, 118.0, 159.0, 122.0], "value": 127.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 151.0, 153.0, 151.0, 153.0, 152.0, 155.0, 151.0, 155.0, 150.0], "value": 152.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 61.0, 67.0, 64.0, 65.0, 64.0, 63.0, 64.0, 62.0, 61.0], "value": 63.6, "unit": "score"}]}]} 08:01:42 INFO - Return code: 0 08:01:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:01:42 ERROR - # TBPL SUCCESS # 08:01:42 INFO - Running post-action listener: _resource_record_post_action 08:01:42 INFO - [mozharness: 2016-09-02 15:01:42.676852Z] Finished run-tests step (success) 08:01:42 INFO - Running post-run listener: _resource_record_post_run 08:01:42 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 266240; Write bytes: 327643136; Read time: 24; Write time: 177260 08:01:42 INFO - TinderboxPrint: CPU usage
13.3% 08:01:42 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 24 08:01:42 INFO - TinderboxPrint: I/O write bytes / time
327,643,136 / 177,260 08:01:42 INFO - TinderboxPrint: CPU idle
8,224.5 (86.7%) 08:01:42 INFO - TinderboxPrint: CPU user
1,205.0 (12.7%) 08:01:42 INFO - TinderboxPrint: Swap in / out
0 / 0 08:01:42 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 77217792; Read time: 0; Write time: 44632 08:01:42 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 262144; Write bytes: 247939072; Read time: 12; Write time: 132380 08:01:43 INFO - Running post-run listener: _upload_blobber_files 08:01:43 INFO - Blob upload gear active. 08:01:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:01:43 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 08:01:43 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'] 08:01:43 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 08:01:43 INFO - (blobuploader) - INFO - Open directory for files ... 08:01:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:01:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:01:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:01:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:01:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:01:44 INFO - (blobuploader) - INFO - Done attempting. 08:01:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:01:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:01:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:01:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:01:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:01:45 INFO - (blobuploader) - INFO - Done attempting. 08:01:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:01:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:01:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:01:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:01:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:01:53 INFO - (blobuploader) - INFO - Done attempting. 08:01:53 INFO - (blobuploader) - INFO - Iteration through files over. 08:01:53 INFO - Return code: 0 08:01:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:01:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:01:53 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/34e52c9d949e4c7d89a0b3b424843f2b514477a3cb3469e6087d5be2d105f335ccdf3b85a7e9f0c13f9c43e58c676029a771f1f3d0a5ad118df424f25c76167c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/877f53618c222bc5424846ed4362bae748a6b308eff08053b24a38bbb83e82eb5b09795a58e8ae11c6a734a63bd8b59f260cb7e251c275fc72c0281489f2c5a0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2e896fbfcabfbf1ba6fd71f83dc6e9dab3e218dc13e4a2f11e00b048c2a29af4586f0714ce5b34ff9e7724e1cfc776d98d879c19bd6594f17e25ab5531e09ce4"} 08:01:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:01:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:01:53 INFO - Contents: 08:01:53 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/34e52c9d949e4c7d89a0b3b424843f2b514477a3cb3469e6087d5be2d105f335ccdf3b85a7e9f0c13f9c43e58c676029a771f1f3d0a5ad118df424f25c76167c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/877f53618c222bc5424846ed4362bae748a6b308eff08053b24a38bbb83e82eb5b09795a58e8ae11c6a734a63bd8b59f260cb7e251c275fc72c0281489f2c5a0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2e896fbfcabfbf1ba6fd71f83dc6e9dab3e218dc13e4a2f11e00b048c2a29af4586f0714ce5b34ff9e7724e1cfc776d98d879c19bd6594f17e25ab5531e09ce4"} 08:01:53 INFO - Running post-run listener: copy_logs_to_upload_dir 08:01:53 INFO - Copying logs to upload dir... 08:01:53 INFO - mkdir: /builds/slave/test/build/upload/logs 08:01:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1681.507944 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 28 mins, 1 secs) (at 2016-09-02 08:01:53.529529) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-02 08:01:53.533461) ========= 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=41bf3e9aed84707956354da8000001c5-1472826568.862178-660793286 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/34e52c9d949e4c7d89a0b3b424843f2b514477a3cb3469e6087d5be2d105f335ccdf3b85a7e9f0c13f9c43e58c676029a771f1f3d0a5ad118df424f25c76167c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/877f53618c222bc5424846ed4362bae748a6b308eff08053b24a38bbb83e82eb5b09795a58e8ae11c6a734a63bd8b59f260cb7e251c275fc72c0281489f2c5a0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2e896fbfcabfbf1ba6fd71f83dc6e9dab3e218dc13e4a2f11e00b048c2a29af4586f0714ce5b34ff9e7724e1cfc776d98d879c19bd6594f17e25ab5531e09ce4"} build_url:https://queue.taskcluster.net/v1/task/ZRc_JytXSZepOmvw-0WyWg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011582 build_url: 'https://queue.taskcluster.net/v1/task/ZRc_JytXSZepOmvw-0WyWg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/34e52c9d949e4c7d89a0b3b424843f2b514477a3cb3469e6087d5be2d105f335ccdf3b85a7e9f0c13f9c43e58c676029a771f1f3d0a5ad118df424f25c76167c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/877f53618c222bc5424846ed4362bae748a6b308eff08053b24a38bbb83e82eb5b09795a58e8ae11c6a734a63bd8b59f260cb7e251c275fc72c0281489f2c5a0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2e896fbfcabfbf1ba6fd71f83dc6e9dab3e218dc13e4a2f11e00b048c2a29af4586f0714ce5b34ff9e7724e1cfc776d98d879c19bd6594f17e25ab5531e09ce4"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-02 08:01:53.559233) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 08:01:53.559584) ========= 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=41bf3e9aed84707956354da8000001c5-1472826568.862178-660793286 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004405 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 08:01:53.644742) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-02 08:01:53.645271) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-02 08:01:53.645746) ========= ========= Total master_lag: 0.18 =========