builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-006 starttime: 1472084030.85 results: success (0) buildid: 20160824072526 builduid: 331913dd534e470f934cd8544daf0d29 revision: e9da92c75a6933143d43fba52e57cad2a7d9246c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-24 17:13:50.850455) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-24 17:13:50.851070) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-24 17:13:50.851406) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-24 17:13:50.908297) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 17:13:50.908851) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1472083093.691465-1315008843 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-24 17:13: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.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 226M=0s 2016-08-24 17:13:51 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.149893 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 17:13:51.083809) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 17:13:51.084186) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1472083093.691465-1315008843 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018159 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 17:13:51.140928) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 17:13:51.141371) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev e9da92c75a6933143d43fba52e57cad2a7d9246c --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 e9da92c75a6933143d43fba52e57cad2a7d9246c --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=e31afd3c0f0de4e86ebe4d94000001b5-1472083093.691465-1315008843 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-24 17:13:51,279 truncating revision to first 12 chars 2016-08-24 17:13:51,279 Setting DEBUG logging. 2016-08-24 17:13:51,279 attempt 1/10 2016-08-24 17:13:51,279 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/e9da92c75a69?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-24 17:13:51,581 unpacking tar archive at: mozilla-aurora-e9da92c75a69/testing/mozharness/ program finished with exit code 0 elapsedTime=0.588190 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 17:13:51.744628) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-24 17:13:51.745166) ========= script_repo_revision: e9da92c75a6933143d43fba52e57cad2a7d9246c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-24 17:13:51.745731) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-24 17:13:51.746158) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-24 17:13:51.761556) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 58 secs) (at 2016-08-24 17:13:51.761882) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e31afd3c0f0de4e86ebe4d94000001b5-1472083093.691465-1315008843 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:13:51 INFO - MultiFileLogger online at 20160824 17:13:51 in /builds/slave/test 17:13:51 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 17:13:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:13:51 INFO - {'append_to_log': False, 17:13:51 INFO - 'base_work_dir': '/builds/slave/test', 17:13:51 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 17:13:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:13:51 INFO - 'branch': 'Mozilla-Aurora', 17:13:51 INFO - 'buildbot_json_path': 'buildprops.json', 17:13:51 INFO - 'config_files': ('talos/linux_config.py',), 17:13:51 INFO - 'default_actions': ('clobber', 17:13:51 INFO - 'read-buildbot-config', 17:13:51 INFO - 'download-and-extract', 17:13:51 INFO - 'populate-webroot', 17:13:51 INFO - 'create-virtualenv', 17:13:51 INFO - 'install', 17:13:51 INFO - 'run-tests'), 17:13:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:13:51 INFO - 'download_minidump_stackwalk': True, 17:13:51 INFO - 'download_symbols': 'ondemand', 17:13:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:13:51 INFO - 'tooltool.py': '/tools/tooltool.py', 17:13:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:13:51 INFO - '/tools/misc-python/virtualenv.py')}, 17:13:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:13:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:13:51 INFO - 'installer_path': 'installer.exe', 17:13:51 INFO - 'log_level': 'info', 17:13:51 INFO - 'log_name': 'talos', 17:13:51 INFO - 'log_to_console': True, 17:13:51 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:13:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:13:51 INFO - 'opt_config_files': (), 17:13:51 INFO - 'pip_index': False, 17:13:51 INFO - 'sps_profile': False, 17:13:51 INFO - 'sps_profile_interval': 0, 17:13:51 INFO - 'suite': 'dromaeojs', 17:13:51 INFO - 'system_bits': '32', 17:13:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:13:51 INFO - 'title': 'talos-linux64-ix-006', 17:13:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:13:51 INFO - 'use_talos_json': True, 17:13:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:13:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:13:51 INFO - 'work_dir': 'build'} 17:13:51 INFO - [mozharness: 2016-08-25 00:13:51.998498Z] Running clobber step. 17:13:51 INFO - Running pre-action listener: _resource_record_pre_action 17:13:51 INFO - Running main action method: clobber 17:13:51 INFO - rmtree: /builds/slave/test/build 17:13:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:13:52 INFO - Running post-action listener: _resource_record_post_action 17:13:52 INFO - [mozharness: 2016-08-25 00:13:52.448082Z] Finished clobber step (success) 17:13:52 INFO - [mozharness: 2016-08-25 00:13:52.448185Z] Running read-buildbot-config step. 17:13:52 INFO - Running pre-action listener: _resource_record_pre_action 17:13:52 INFO - Running main action method: read_buildbot_config 17:13:52 INFO - Using buildbot properties: 17:13:52 INFO - { 17:13:52 INFO - "project": "", 17:13:52 INFO - "product": "firefox", 17:13:52 INFO - "script_repo_revision": "production", 17:13:52 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 17:13:52 INFO - "repository": "", 17:13:52 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 17:13:52 INFO - "buildid": "20160824072526", 17:13:52 INFO - "pgo_build": "True", 17:13:52 INFO - "basedir": "/builds/slave/test", 17:13:52 INFO - "buildnumber": 489, 17:13:52 INFO - "slavename": "talos-linux64-ix-006", 17:13:52 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 17:13:52 INFO - "platform": "ubuntu64_hw", 17:13:52 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 17:13:52 INFO - "branch": "mozilla-aurora", 17:13:52 INFO - "repo_path": "releases/mozilla-aurora", 17:13:52 INFO - "revision": "e9da92c75a6933143d43fba52e57cad2a7d9246c", 17:13:52 INFO - "stage_platform": "linux64-pgo", 17:13:52 INFO - "builduid": "331913dd534e470f934cd8544daf0d29", 17:13:52 INFO - "slavebuilddir": "test" 17:13:52 INFO - } 17:13:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/bcmiRztOSyC-Xb4vJQBXKQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2. 17:13:52 INFO - Running post-action listener: _resource_record_post_action 17:13:52 INFO - [mozharness: 2016-08-25 00:13:52.450636Z] Finished read-buildbot-config step (success) 17:13:52 INFO - [mozharness: 2016-08-25 00:13:52.450726Z] Running download-and-extract step. 17:13:52 INFO - Running pre-action listener: _resource_record_pre_action 17:13:52 INFO - Running main action method: download_and_extract 17:13:52 INFO - mkdir: /builds/slave/test/build/tests 17:13: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')]} 17:13:52 INFO - https://queue.taskcluster.net/v1/task/bcmiRztOSyC-Xb4vJQBXKQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:13:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bcmiRztOSyC-Xb4vJQBXKQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 17:13:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bcmiRztOSyC-Xb4vJQBXKQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 17:13:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bcmiRztOSyC-Xb4vJQBXKQ/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 17:13:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bcmiRztOSyC-Xb4vJQBXKQ/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 17:13:52 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bcmiRztOSyC-Xb4vJQBXKQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 17:13:52 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 17:13:52 INFO - retry: Failed, sleeping 30 seconds before retrying 17:14:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bcmiRztOSyC-Xb4vJQBXKQ/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 17:14:22 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bcmiRztOSyC-Xb4vJQBXKQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 17:14:22 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 17:14:22 INFO - retry: Failed, sleeping 60 seconds before retrying 17:15:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bcmiRztOSyC-Xb4vJQBXKQ/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 17:15:22 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bcmiRztOSyC-Xb4vJQBXKQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 17:15:22 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 17:15:22 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bcmiRztOSyC-Xb4vJQBXKQ/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! 17:15:22 INFO - Caught exception: HTTP Error 404: Not Found 17:15:22 INFO - Caught exception: HTTP Error 404: Not Found 17:15:22 INFO - Caught exception: HTTP Error 404: Not Found 17:15:22 INFO - trying https://queue.taskcluster.net/v1/task/bcmiRztOSyC-Xb4vJQBXKQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 17:15:22 INFO - Downloading https://queue.taskcluster.net/v1/task/bcmiRztOSyC-Xb4vJQBXKQ/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 17:15:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bcmiRztOSyC-Xb4vJQBXKQ/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 17:15:23 INFO - Downloaded 1361 bytes. 17:15:23 INFO - Reading from file /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 17:15:23 INFO - Using the following test package requirements: 17:15:23 INFO - {u'common': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 17:15:23 INFO - u'cppunittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 17:15:23 INFO - u'firefox-50.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 17:15:23 INFO - u'gtest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 17:15:23 INFO - u'firefox-50.0a2.en-US.linux-x86_64.gtest.tests.zip'], 17:15:23 INFO - u'jittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 17:15:23 INFO - u'jsshell-linux-x86_64.zip'], 17:15:23 INFO - u'mochitest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 17:15:23 INFO - u'firefox-50.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 17:15:23 INFO - u'mozbase': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 17:15:23 INFO - u'reftest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 17:15:23 INFO - u'firefox-50.0a2.en-US.linux-x86_64.reftest.tests.zip'], 17:15:23 INFO - u'talos': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 17:15:23 INFO - u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'], 17:15:23 INFO - u'web-platform': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 17:15:23 INFO - u'firefox-50.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 17:15:23 INFO - u'xpcshell': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 17:15:23 INFO - u'firefox-50.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 17:15:23 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:15: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')]} 17:15:23 INFO - https://queue.taskcluster.net/v1/task/bcmiRztOSyC-Xb4vJQBXKQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:15:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bcmiRztOSyC-Xb4vJQBXKQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 17:15:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bcmiRztOSyC-Xb4vJQBXKQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 17:15:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bcmiRztOSyC-Xb4vJQBXKQ/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 17:15:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bcmiRztOSyC-Xb4vJQBXKQ/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 17:15:23 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bcmiRztOSyC-Xb4vJQBXKQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 17:15:23 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 17:15:23 INFO - retry: Failed, sleeping 30 seconds before retrying 17:15:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bcmiRztOSyC-Xb4vJQBXKQ/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 17:15:53 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bcmiRztOSyC-Xb4vJQBXKQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 17:15:53 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 17:15:53 INFO - retry: Failed, sleeping 60 seconds before retrying 17:16:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bcmiRztOSyC-Xb4vJQBXKQ/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 17:16:53 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bcmiRztOSyC-Xb4vJQBXKQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 17:16:53 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 17:16:53 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bcmiRztOSyC-Xb4vJQBXKQ/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! 17:16:53 INFO - Caught exception: HTTP Error 404: Not Found 17:16:53 INFO - Caught exception: HTTP Error 404: Not Found 17:16:53 INFO - Caught exception: HTTP Error 404: Not Found 17:16:53 INFO - trying https://queue.taskcluster.net/v1/task/bcmiRztOSyC-Xb4vJQBXKQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 17:16:53 INFO - Downloading https://queue.taskcluster.net/v1/task/bcmiRztOSyC-Xb4vJQBXKQ/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 17:16:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bcmiRztOSyC-Xb4vJQBXKQ/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 17:16:54 INFO - Downloaded 21768541 bytes. 17:16: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'] 17:16: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 17:16:55 INFO - Return code: 0 17:16: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 17:16: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')]} 17:16:55 INFO - https://queue.taskcluster.net/v1/task/bcmiRztOSyC-Xb4vJQBXKQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:16:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bcmiRztOSyC-Xb4vJQBXKQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 17:16:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bcmiRztOSyC-Xb4vJQBXKQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 17:16:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bcmiRztOSyC-Xb4vJQBXKQ/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 17:16:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bcmiRztOSyC-Xb4vJQBXKQ/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 17:16:55 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bcmiRztOSyC-Xb4vJQBXKQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 17:16:55 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 17:16:55 INFO - retry: Failed, sleeping 30 seconds before retrying 17:17:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bcmiRztOSyC-Xb4vJQBXKQ/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 17:17:25 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bcmiRztOSyC-Xb4vJQBXKQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 17:17:25 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 17:17:25 INFO - retry: Failed, sleeping 60 seconds before retrying 17:18:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bcmiRztOSyC-Xb4vJQBXKQ/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 17:18:25 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bcmiRztOSyC-Xb4vJQBXKQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 17:18:25 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 17:18:25 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bcmiRztOSyC-Xb4vJQBXKQ/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! 17:18:25 INFO - Caught exception: HTTP Error 404: Not Found 17:18:25 INFO - Caught exception: HTTP Error 404: Not Found 17:18:25 INFO - Caught exception: HTTP Error 404: Not Found 17:18:25 INFO - trying https://queue.taskcluster.net/v1/task/bcmiRztOSyC-Xb4vJQBXKQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 17:18:25 INFO - Downloading https://queue.taskcluster.net/v1/task/bcmiRztOSyC-Xb4vJQBXKQ/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 17:18:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bcmiRztOSyC-Xb4vJQBXKQ/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 17:18:26 INFO - Downloaded 21768541 bytes. 17:18: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'] 17:18: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 17:18:27 INFO - Return code: 0 17:18:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:18:27 INFO - https://queue.taskcluster.net/v1/task/bcmiRztOSyC-Xb4vJQBXKQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:18:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bcmiRztOSyC-Xb4vJQBXKQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 17:18:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bcmiRztOSyC-Xb4vJQBXKQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 17:18:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bcmiRztOSyC-Xb4vJQBXKQ/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 17:18:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bcmiRztOSyC-Xb4vJQBXKQ/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 17:18:27 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bcmiRztOSyC-Xb4vJQBXKQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 17:18:27 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 17:18:27 INFO - retry: Failed, sleeping 30 seconds before retrying 17:18:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bcmiRztOSyC-Xb4vJQBXKQ/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 17:18:57 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bcmiRztOSyC-Xb4vJQBXKQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 17:18:57 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 17:18:57 INFO - retry: Failed, sleeping 60 seconds before retrying 17:19:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bcmiRztOSyC-Xb4vJQBXKQ/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 17:19:57 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bcmiRztOSyC-Xb4vJQBXKQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 17:19:57 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 17:19:57 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bcmiRztOSyC-Xb4vJQBXKQ/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! 17:19:57 INFO - Caught exception: HTTP Error 404: Not Found 17:19:57 INFO - Caught exception: HTTP Error 404: Not Found 17:19:57 INFO - Caught exception: HTTP Error 404: Not Found 17:19:57 INFO - trying https://queue.taskcluster.net/v1/task/bcmiRztOSyC-Xb4vJQBXKQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 17:19:57 INFO - Downloading https://queue.taskcluster.net/v1/task/bcmiRztOSyC-Xb4vJQBXKQ/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 17:19:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bcmiRztOSyC-Xb4vJQBXKQ/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 17:19:59 INFO - Downloaded 14413723 bytes. 17:19: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'] 17:19: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 17:19:59 INFO - Return code: 0 17:19: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')]} 17:19:59 INFO - https://queue.taskcluster.net/v1/task/bcmiRztOSyC-Xb4vJQBXKQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:19:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bcmiRztOSyC-Xb4vJQBXKQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 17:19:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bcmiRztOSyC-Xb4vJQBXKQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 17:19:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bcmiRztOSyC-Xb4vJQBXKQ/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 17:19:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bcmiRztOSyC-Xb4vJQBXKQ/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 17:19:59 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bcmiRztOSyC-Xb4vJQBXKQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 17:19:59 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 17:19:59 INFO - retry: Failed, sleeping 30 seconds before retrying 17:20:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bcmiRztOSyC-Xb4vJQBXKQ/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 17:20:29 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bcmiRztOSyC-Xb4vJQBXKQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 17:20:29 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 17:20:29 INFO - retry: Failed, sleeping 60 seconds before retrying 17:21:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bcmiRztOSyC-Xb4vJQBXKQ/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 17:21:29 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bcmiRztOSyC-Xb4vJQBXKQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 17:21:29 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 17:21:29 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bcmiRztOSyC-Xb4vJQBXKQ/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! 17:21:29 INFO - Caught exception: HTTP Error 404: Not Found 17:21:29 INFO - Caught exception: HTTP Error 404: Not Found 17:21:29 INFO - Caught exception: HTTP Error 404: Not Found 17:21:29 INFO - trying https://queue.taskcluster.net/v1/task/bcmiRztOSyC-Xb4vJQBXKQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 17:21:29 INFO - Downloading https://queue.taskcluster.net/v1/task/bcmiRztOSyC-Xb4vJQBXKQ/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 17:21:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bcmiRztOSyC-Xb4vJQBXKQ/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 17:21:31 INFO - Downloaded 63747660 bytes. 17:21:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bcmiRztOSyC-Xb4vJQBXKQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 17:21:31 INFO - mkdir: /builds/slave/test/properties 17:21:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:21:31 INFO - Writing to file /builds/slave/test/properties/build_url 17:21:31 INFO - Contents: 17:21:31 INFO - build_url:https://queue.taskcluster.net/v1/task/bcmiRztOSyC-Xb4vJQBXKQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 17:21:31 INFO - Running post-action listener: _resource_record_post_action 17:21:31 INFO - Running post-action listener: set_extra_try_arguments 17:21:31 INFO - [mozharness: 2016-08-25 00:21:31.774269Z] Finished download-and-extract step (success) 17:21:31 INFO - [mozharness: 2016-08-25 00:21:31.774507Z] Running populate-webroot step. 17:21:31 INFO - Running pre-action listener: _resource_record_pre_action 17:21:31 INFO - Running main action method: populate_webroot 17:21:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:21:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:21:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:21:31 INFO - '--tppagecycles', 17:21:31 INFO - '7'], 17:21:31 INFO - 'tests': ['tsvgm']}}, 17:21:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:21:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:21:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:21:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:21:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:21:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:21:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:21:31 INFO - 'talos_options': ['--disable-e10s'], 17:21:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:21:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:21:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:21:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:21:31 INFO - 'talos_options': ['--disable-e10s'], 17:21:31 INFO - 'tests': ['damp', 'tps']}, 17:21:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:21:31 INFO - 'tests': ['damp', 'tps']}, 17:21:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:21:31 INFO - 'tests': ['dromaeo_dom']}, 17:21:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:21:31 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:21:31 INFO - 'tests': ['basic_compositor_video']}, 17:21:31 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:21:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:21:31 INFO - 'tests': ['a11yr', 17:21:31 INFO - 'ts_paint', 17:21:31 INFO - 'tpaint', 17:21:31 INFO - 'sessionrestore', 17:21:31 INFO - 'sessionrestore_no_auto_restore', 17:21:31 INFO - 'tabpaint']}, 17:21:31 INFO - 'other-e10s': {'tests': ['a11yr', 17:21:31 INFO - 'ts_paint', 17:21:31 INFO - 'tpaint', 17:21:31 INFO - 'sessionrestore', 17:21:31 INFO - 'sessionrestore_no_auto_restore', 17:21:31 INFO - 'tabpaint']}, 17:21:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:21:31 INFO - 'ts_paint', 17:21:31 INFO - 'tpaint', 17:21:31 INFO - 'sessionrestore', 17:21:31 INFO - 'sessionrestore_no_auto_restore', 17:21:31 INFO - 'tabpaint']}, 17:21:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:21:31 INFO - 'ts_paint', 17:21:31 INFO - 'tpaint', 17:21:31 INFO - 'sessionrestore', 17:21:31 INFO - 'sessionrestore_no_auto_restore', 17:21:31 INFO - 'tabpaint']}, 17:21:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:21:31 INFO - 'tests': ['a11yr', 17:21:31 INFO - 'ts_paint', 17:21:31 INFO - 'tpaint', 17:21:31 INFO - 'sessionrestore', 17:21:31 INFO - 'sessionrestore_no_auto_restore', 17:21:31 INFO - 'tabpaint']}, 17:21:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:21:31 INFO - 'tests': ['a11yr', 17:21:31 INFO - 'ts_paint', 17:21:31 INFO - 'tpaint', 17:21:31 INFO - 'sessionrestore', 17:21:31 INFO - 'sessionrestore_no_auto_restore', 17:21:31 INFO - 'tabpaint']}, 17:21:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:21:31 INFO - 'tests': ['tsvgx', 17:21:31 INFO - 'tsvgr_opacity', 17:21:31 INFO - 'tart', 17:21:31 INFO - 'tscrollx', 17:21:31 INFO - 'cart']}, 17:21:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:21:31 INFO - 'tsvgr_opacity', 17:21:31 INFO - 'tart', 17:21:31 INFO - 'tscrollx', 17:21:31 INFO - 'cart']}, 17:21:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:21:31 INFO - 'talos_options': ['--disable-e10s'], 17:21:31 INFO - 'tests': ['tp5o']}, 17:21:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:21:31 INFO - 'tests': ['tp5o']}, 17:21:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:21:31 INFO - 'talos_options': ['--disable-e10s', 17:21:31 INFO - '--xperf_path', 17:21:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:21:31 INFO - 'tests': ['tp5n']}, 17:21:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:21:31 INFO - 'talos_options': ['--xperf_path', 17:21:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:21:31 INFO - 'tests': ['tp5n']}}, 17:21:31 INFO - 'talos.zip': {'path': '', 17:21:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:21:31 INFO - Running post-action listener: _resource_record_post_action 17:21:31 INFO - [mozharness: 2016-08-25 00:21:31.790092Z] Finished populate-webroot step (success) 17:21:31 INFO - [mozharness: 2016-08-25 00:21:31.790182Z] Running create-virtualenv step. 17:21:31 INFO - Running pre-action listener: _resource_record_pre_action 17:21:31 INFO - Running main action method: create_virtualenv 17:21:31 INFO - Creating virtualenv /builds/slave/test/build/venv 17:21: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 17:21:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:21:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:21:31 INFO - Using real prefix '/usr' 17:21:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:21:32 INFO - Installing distribute.............................................................................................................................................................................................done. 17:21:34 INFO - Installing pip.................done. 17:21:34 INFO - Return code: 0 17:21:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:21: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')]} 17:21:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:21:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21: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')]} 17:21:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:21:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21: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 0x17df030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9e3b0>, '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 0x1a9f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a9f740>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1472083093.691465-1315008843', '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 17:21: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 17:21: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 17:21:34 INFO - Using env: {'DISPLAY': ':0', 17:21:34 INFO - 'HOME': '/home/cltbld', 17:21:34 INFO - 'LANG': 'en_US.UTF-8', 17:21:34 INFO - 'LANGUAGE': 'en_US:en', 17:21:34 INFO - 'LOGNAME': 'cltbld', 17:21:34 INFO - 'MAIL': '/var/mail/cltbld', 17:21:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:21:34 INFO - 'MOZ_NO_REMOTE': '1', 17:21:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:21:34 INFO - 'NO_EM_RESTART': '1', 17:21:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:21:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:21:34 INFO - 'PWD': '/builds/slave/test', 17:21:34 INFO - 'SHELL': '/bin/bash', 17:21:34 INFO - 'SHLVL': '1', 17:21:34 INFO - 'TERM': 'linux', 17:21:34 INFO - 'TMOUT': '86400', 17:21:34 INFO - 'USER': 'cltbld', 17:21:34 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1472083093.691465-1315008843', 17:21:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:21:34 INFO - '_': '/tools/buildbot/bin/python'} 17:21:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:21: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 17:21:34 INFO - Cleaning up... 17:21:34 INFO - Return code: 0 17:21:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:21: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')]} 17:21:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:21:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21: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')]} 17:21:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:21:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21: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 0x17df030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9e3b0>, '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 0x1a9f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a9f740>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1472083093.691465-1315008843', '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 17:21: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 17:21: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 17:21:34 INFO - Using env: {'DISPLAY': ':0', 17:21:34 INFO - 'HOME': '/home/cltbld', 17:21:34 INFO - 'LANG': 'en_US.UTF-8', 17:21:34 INFO - 'LANGUAGE': 'en_US:en', 17:21:34 INFO - 'LOGNAME': 'cltbld', 17:21:34 INFO - 'MAIL': '/var/mail/cltbld', 17:21:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:21:34 INFO - 'MOZ_NO_REMOTE': '1', 17:21:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:21:34 INFO - 'NO_EM_RESTART': '1', 17:21:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:21:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:21:34 INFO - 'PWD': '/builds/slave/test', 17:21:34 INFO - 'SHELL': '/bin/bash', 17:21:34 INFO - 'SHLVL': '1', 17:21:34 INFO - 'TERM': 'linux', 17:21:34 INFO - 'TMOUT': '86400', 17:21:34 INFO - 'USER': 'cltbld', 17:21:34 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1472083093.691465-1315008843', 17:21:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:21:34 INFO - '_': '/tools/buildbot/bin/python'} 17:21:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:21:34 INFO - Downloading/unpacking psutil>=3.1.1 17:21: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 17:21: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 17:21: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 17:21: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 17:21: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 17:21: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 17:21:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:21:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:21:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:21:36 INFO - Installing collected packages: psutil 17:21:36 INFO - Running setup.py install for psutil 17:21:36 INFO - building 'psutil._psutil_linux' extension 17:21: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 17:21: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 17:21:37 INFO - building 'psutil._psutil_posix' extension 17:21: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 17:21: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 17:21:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:21:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:21:37 INFO - Successfully installed psutil 17:21:37 INFO - Cleaning up... 17:21:37 INFO - Return code: 0 17:21:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:21: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')]} 17:21:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:21:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21: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')]} 17:21:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:21:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21: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 0x17df030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9e3b0>, '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 0x1a9f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a9f740>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1472083093.691465-1315008843', '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 17:21: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 17:21: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 17:21:37 INFO - Using env: {'DISPLAY': ':0', 17:21:37 INFO - 'HOME': '/home/cltbld', 17:21:37 INFO - 'LANG': 'en_US.UTF-8', 17:21:37 INFO - 'LANGUAGE': 'en_US:en', 17:21:37 INFO - 'LOGNAME': 'cltbld', 17:21:37 INFO - 'MAIL': '/var/mail/cltbld', 17:21:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:21:37 INFO - 'MOZ_NO_REMOTE': '1', 17:21:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:21:37 INFO - 'NO_EM_RESTART': '1', 17:21:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:21:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:21:37 INFO - 'PWD': '/builds/slave/test', 17:21:37 INFO - 'SHELL': '/bin/bash', 17:21:37 INFO - 'SHLVL': '1', 17:21:37 INFO - 'TERM': 'linux', 17:21:37 INFO - 'TMOUT': '86400', 17:21:37 INFO - 'USER': 'cltbld', 17:21:37 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1472083093.691465-1315008843', 17:21:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:21:37 INFO - '_': '/tools/buildbot/bin/python'} 17:21:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:21:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:21: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 17:21: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 17:21: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 17:21: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 17:21: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 17:21: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 17:21:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:21:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:21:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:21:39 INFO - Installing collected packages: mozsystemmonitor 17:21:39 INFO - Running setup.py install for mozsystemmonitor 17:21:39 INFO - Successfully installed mozsystemmonitor 17:21:39 INFO - Cleaning up... 17:21:39 INFO - Return code: 0 17:21:39 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:21: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')]} 17:21:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:21:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21: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')]} 17:21:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:21:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21: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 0x17df030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9e3b0>, '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 0x1a9f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a9f740>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1472083093.691465-1315008843', '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 17:21: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 17:21: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 17:21:39 INFO - Using env: {'DISPLAY': ':0', 17:21:39 INFO - 'HOME': '/home/cltbld', 17:21:39 INFO - 'LANG': 'en_US.UTF-8', 17:21:39 INFO - 'LANGUAGE': 'en_US:en', 17:21:39 INFO - 'LOGNAME': 'cltbld', 17:21:39 INFO - 'MAIL': '/var/mail/cltbld', 17:21:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:21:39 INFO - 'MOZ_NO_REMOTE': '1', 17:21:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:21:39 INFO - 'NO_EM_RESTART': '1', 17:21:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:21:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:21:39 INFO - 'PWD': '/builds/slave/test', 17:21:39 INFO - 'SHELL': '/bin/bash', 17:21:39 INFO - 'SHLVL': '1', 17:21:39 INFO - 'TERM': 'linux', 17:21:39 INFO - 'TMOUT': '86400', 17:21:39 INFO - 'USER': 'cltbld', 17:21:39 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1472083093.691465-1315008843', 17:21:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:21:39 INFO - '_': '/tools/buildbot/bin/python'} 17:21:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:21:39 INFO - Downloading/unpacking jsonschema==2.5.1 17:21: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 17:21: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 17:21: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 17:21: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 17:21: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 17:21: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 17:21:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:21:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:21: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 17:21: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 17:21: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 17:21: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 17:21: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 17:21: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 17:21:41 INFO - Downloading functools32-3.2.3-2.tar.gz 17:21:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:21:41 INFO - warning: no files found matching '*.txt' 17:21:41 INFO - no previously-included directories found matching 'build' 17:21:41 INFO - no previously-included directories found matching 'dist' 17:21:41 INFO - no previously-included directories found matching '.git*' 17:21:41 INFO - Installing collected packages: jsonschema, functools32 17:21:42 INFO - Running setup.py install for functools32 17:21:42 INFO - warning: no files found matching '*.txt' 17:21:42 INFO - no previously-included directories found matching 'build' 17:21:42 INFO - no previously-included directories found matching 'dist' 17:21:42 INFO - no previously-included directories found matching '.git*' 17:21:42 INFO - Successfully installed jsonschema functools32 17:21:42 INFO - Cleaning up... 17:21:42 INFO - Return code: 0 17:21:42 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:21: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')]} 17:21:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:21:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21: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')]} 17:21:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:21:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21: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 0x17df030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9e3b0>, '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 0x1a9f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a9f740>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1472083093.691465-1315008843', '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 17:21: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 17:21: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 17:21:42 INFO - Using env: {'DISPLAY': ':0', 17:21:42 INFO - 'HOME': '/home/cltbld', 17:21:42 INFO - 'LANG': 'en_US.UTF-8', 17:21:42 INFO - 'LANGUAGE': 'en_US:en', 17:21:42 INFO - 'LOGNAME': 'cltbld', 17:21:42 INFO - 'MAIL': '/var/mail/cltbld', 17:21:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:21:42 INFO - 'MOZ_NO_REMOTE': '1', 17:21:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:21:42 INFO - 'NO_EM_RESTART': '1', 17:21:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:21:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:21:42 INFO - 'PWD': '/builds/slave/test', 17:21:42 INFO - 'SHELL': '/bin/bash', 17:21:42 INFO - 'SHLVL': '1', 17:21:42 INFO - 'TERM': 'linux', 17:21:42 INFO - 'TMOUT': '86400', 17:21:42 INFO - 'USER': 'cltbld', 17:21:42 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1472083093.691465-1315008843', 17:21:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:21:42 INFO - '_': '/tools/buildbot/bin/python'} 17:21:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:21:42 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:21:42 INFO - Cleaning up... 17:21:42 INFO - Return code: 0 17:21:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:21: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')]} 17:21:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:21:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21: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')]} 17:21:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:21:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21: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 0x17df030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9e3b0>, '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 0x1a9f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a9f740>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1472083093.691465-1315008843', '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 17:21: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 17:21: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 17:21:42 INFO - Using env: {'DISPLAY': ':0', 17:21:42 INFO - 'HOME': '/home/cltbld', 17:21:42 INFO - 'LANG': 'en_US.UTF-8', 17:21:42 INFO - 'LANGUAGE': 'en_US:en', 17:21:42 INFO - 'LOGNAME': 'cltbld', 17:21:42 INFO - 'MAIL': '/var/mail/cltbld', 17:21:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:21:42 INFO - 'MOZ_NO_REMOTE': '1', 17:21:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:21:42 INFO - 'NO_EM_RESTART': '1', 17:21:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:21:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:21:42 INFO - 'PWD': '/builds/slave/test', 17:21:42 INFO - 'SHELL': '/bin/bash', 17:21:42 INFO - 'SHLVL': '1', 17:21:42 INFO - 'TERM': 'linux', 17:21:42 INFO - 'TMOUT': '86400', 17:21:42 INFO - 'USER': 'cltbld', 17:21:42 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1472083093.691465-1315008843', 17:21:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:21:42 INFO - '_': '/tools/buildbot/bin/python'} 17:21:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:21:42 INFO - Downloading/unpacking blobuploader==1.2.4 17:21: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 17:21: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 17:21: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 17:21: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 17:21: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 17:21: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 17:21:44 INFO - Downloading blobuploader-1.2.4.tar.gz 17:21:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:21:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:21: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 17:21: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 17:21: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 17:21: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 17:21: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 17:21: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 17:21:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:21:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:21: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 17:21: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 17:21: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 17:21: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 17:21: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 17:21: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 17:21:45 INFO - Downloading docopt-0.6.1.tar.gz 17:21:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:21:45 INFO - Installing collected packages: blobuploader, requests, docopt 17:21:45 INFO - Running setup.py install for blobuploader 17:21:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:21:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:21:45 INFO - Running setup.py install for requests 17:21:45 INFO - Running setup.py install for docopt 17:21:45 INFO - Successfully installed blobuploader requests docopt 17:21:45 INFO - Cleaning up... 17:21:45 INFO - Return code: 0 17:21:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:21:45 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')]} 17:21:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:21:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21:45 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')]} 17:21:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:21:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21:45 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 0x17df030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9e3b0>, '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 0x1a9f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a9f740>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1472083093.691465-1315008843', '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 17:21:45 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 17:21:45 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 17:21:45 INFO - Using env: {'DISPLAY': ':0', 17:21:45 INFO - 'HOME': '/home/cltbld', 17:21:45 INFO - 'LANG': 'en_US.UTF-8', 17:21:45 INFO - 'LANGUAGE': 'en_US:en', 17:21:45 INFO - 'LOGNAME': 'cltbld', 17:21:45 INFO - 'MAIL': '/var/mail/cltbld', 17:21:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:21:45 INFO - 'MOZ_NO_REMOTE': '1', 17:21:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:21:45 INFO - 'NO_EM_RESTART': '1', 17:21:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:21:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:21:45 INFO - 'PWD': '/builds/slave/test', 17:21:45 INFO - 'SHELL': '/bin/bash', 17:21:45 INFO - 'SHLVL': '1', 17:21:45 INFO - 'TERM': 'linux', 17:21:45 INFO - 'TMOUT': '86400', 17:21:45 INFO - 'USER': 'cltbld', 17:21:45 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1472083093.691465-1315008843', 17:21:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:21:45 INFO - '_': '/tools/buildbot/bin/python'} 17:21:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:21:46 INFO - Running setup.py (path:/tmp/pip-5rihiG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:21:46 INFO - Running setup.py (path:/tmp/pip-da84yx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:21:46 INFO - Running setup.py (path:/tmp/pip-CSmIjG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:21:46 INFO - Running setup.py (path:/tmp/pip-nK51EE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:21:46 INFO - Running setup.py (path:/tmp/pip-hiaa4K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:21:46 INFO - Running setup.py (path:/tmp/pip-gXa9QN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:21:46 INFO - Running setup.py (path:/tmp/pip-b6CmwU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:21:46 INFO - Running setup.py (path:/tmp/pip-LX5dvb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:21:46 INFO - Running setup.py (path:/tmp/pip-0sYaSG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:21:46 INFO - Running setup.py (path:/tmp/pip-8cVKEe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:21:46 INFO - Running setup.py (path:/tmp/pip-yFVgJA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:21:46 INFO - Running setup.py (path:/tmp/pip-lP4Kay-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:21:46 INFO - Running setup.py (path:/tmp/pip-RkEAqJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:21:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:21:47 INFO - Running setup.py (path:/tmp/pip-Ado6yx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:21:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:21:47 INFO - Running setup.py (path:/tmp/pip-FTM1Ae-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:21:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:21:47 INFO - Running setup.py (path:/tmp/pip-56bzt8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:21:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:21:47 INFO - Running setup.py (path:/tmp/pip-lb80w4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:21:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:21:47 INFO - Running setup.py install for manifestparser 17:21:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:21:47 INFO - Running setup.py install for mozcrash 17:21:47 INFO - Running setup.py install for mozdebug 17:21:47 INFO - Running setup.py install for mozdevice 17:21:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:21:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:21:47 INFO - Running setup.py install for mozfile 17:21:47 INFO - Running setup.py install for mozhttpd 17:21:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:21:47 INFO - Running setup.py install for mozinfo 17:21:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:21:48 INFO - Running setup.py install for mozInstall 17:21:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:21:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:21:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:21:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:21:48 INFO - Running setup.py install for mozleak 17:21:48 INFO - Running setup.py install for mozlog 17:21:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:21:48 INFO - Running setup.py install for moznetwork 17:21:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:21:48 INFO - Running setup.py install for mozprocess 17:21:48 INFO - Running setup.py install for mozprofile 17:21:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:21:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:21:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:21:48 INFO - Running setup.py install for mozrunner 17:21:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:21:48 INFO - Running setup.py install for mozscreenshot 17:21:48 INFO - Running setup.py install for moztest 17:21:48 INFO - Running setup.py install for mozversion 17:21:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:21:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:21:49 INFO - Cleaning up... 17:21:49 INFO - Return code: 0 17:21:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:21: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')]} 17:21:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:21:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21: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')]} 17:21:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:21:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21: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 0x17df030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9e3b0>, '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 0x1a9f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a9f740>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1472083093.691465-1315008843', '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 17:21: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 17:21: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 17:21:49 INFO - Using env: {'DISPLAY': ':0', 17:21:49 INFO - 'HOME': '/home/cltbld', 17:21:49 INFO - 'LANG': 'en_US.UTF-8', 17:21:49 INFO - 'LANGUAGE': 'en_US:en', 17:21:49 INFO - 'LOGNAME': 'cltbld', 17:21:49 INFO - 'MAIL': '/var/mail/cltbld', 17:21:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:21:49 INFO - 'MOZ_NO_REMOTE': '1', 17:21:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:21:49 INFO - 'NO_EM_RESTART': '1', 17:21:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:21:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:21:49 INFO - 'PWD': '/builds/slave/test', 17:21:49 INFO - 'SHELL': '/bin/bash', 17:21:49 INFO - 'SHLVL': '1', 17:21:49 INFO - 'TERM': 'linux', 17:21:49 INFO - 'TMOUT': '86400', 17:21:49 INFO - 'USER': 'cltbld', 17:21:49 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1472083093.691465-1315008843', 17:21:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:21:49 INFO - '_': '/tools/buildbot/bin/python'} 17:21:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:21:49 INFO - Running setup.py (path:/tmp/pip-CUyjUA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:21: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)) 17:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:21:49 INFO - Running setup.py (path:/tmp/pip-KlMwhk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:21: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)) 17:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:21:49 INFO - Running setup.py (path:/tmp/pip-H7g5vE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:21: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)) 17:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:21:49 INFO - Running setup.py (path:/tmp/pip-sEfPgr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:21: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)) 17:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:21:49 INFO - Running setup.py (path:/tmp/pip-pNIup3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:21: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)) 17:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:21:49 INFO - Running setup.py (path:/tmp/pip-MkvQDA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:21: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)) 17:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:21:49 INFO - Running setup.py (path:/tmp/pip-SxdEyu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:21:49 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)) 17:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:21:49 INFO - Running setup.py (path:/tmp/pip-G2mw1s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:21:49 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)) 17:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:21:49 INFO - Running setup.py (path:/tmp/pip-dwu8WM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:21:49 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)) 17:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:21:49 INFO - Running setup.py (path:/tmp/pip-l88i4G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:21: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)) 17:21:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:21:50 INFO - Running setup.py (path:/tmp/pip-nsMVRv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:21: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)) 17:21:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:21:50 INFO - Running setup.py (path:/tmp/pip-WRQbUr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:21: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)) 17:21:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:21:50 INFO - Running setup.py (path:/tmp/pip-FOHWC4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:21: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)) 17:21:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:21:50 INFO - Running setup.py (path:/tmp/pip-xLF4e5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:21: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)) 17:21:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:21:50 INFO - Running setup.py (path:/tmp/pip-arIMkL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:21: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)) 17:21:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:21:50 INFO - Running setup.py (path:/tmp/pip-97xPFV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:21: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)) 17:21:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:21:50 INFO - Running setup.py (path:/tmp/pip-Nz9snw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:21: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)) 17:21: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)) 17:21: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)) 17:21: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)) 17:21: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)) 17:21: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)) 17:21:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:21: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 17:21: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 17:21: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 17:21: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 17:21: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 17:21: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 17:21:52 INFO - Downloading blessings-1.6.tar.gz 17:21:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:21:52 INFO - Installing collected packages: blessings 17:21:52 INFO - Running setup.py install for blessings 17:21:52 INFO - Successfully installed blessings 17:21:52 INFO - Cleaning up... 17:21:52 INFO - Return code: 0 17:21:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:21:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:21:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:21:52 INFO - Reading from file tmpfile_stdout 17:21:52 INFO - Current package versions: 17:21:52 INFO - argparse == 1.2.1 17:21:52 INFO - blessings == 1.6 17:21:52 INFO - blobuploader == 1.2.4 17:21:52 INFO - docopt == 0.6.1 17:21:52 INFO - functools32 == 3.2.3-2 17:21:52 INFO - jsonschema == 2.5.1 17:21:52 INFO - manifestparser == 1.1 17:21:52 INFO - mozInstall == 1.12 17:21:52 INFO - mozcrash == 0.17 17:21:52 INFO - mozdebug == 0.1 17:21:52 INFO - mozdevice == 0.48 17:21:52 INFO - mozfile == 1.2 17:21:52 INFO - mozhttpd == 0.7 17:21:52 INFO - mozinfo == 0.9 17:21:52 INFO - mozleak == 0.1 17:21:52 INFO - mozlog == 3.3 17:21:52 INFO - moznetwork == 0.27 17:21:52 INFO - mozprocess == 0.23 17:21:52 INFO - mozprofile == 0.28 17:21:52 INFO - mozrunner == 6.12 17:21:52 INFO - mozscreenshot == 0.1 17:21:52 INFO - mozsystemmonitor == 0.3 17:21:52 INFO - moztest == 0.7 17:21:52 INFO - mozversion == 1.4 17:21:52 INFO - psutil == 3.1.1 17:21:52 INFO - requests == 1.2.3 17:21:52 INFO - wsgiref == 0.1.2 17:21:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:21: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')]} 17:21:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:21:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21: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')]} 17:21:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:21:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21:52 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 0x17df030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9e3b0>, '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 0x1a9f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a9f740>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1472083093.691465-1315008843', '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 17:21:52 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 17:21:52 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 17:21:52 INFO - Using env: {'DISPLAY': ':0', 17:21:52 INFO - 'HOME': '/home/cltbld', 17:21:52 INFO - 'LANG': 'en_US.UTF-8', 17:21:52 INFO - 'LANGUAGE': 'en_US:en', 17:21:52 INFO - 'LOGNAME': 'cltbld', 17:21:52 INFO - 'MAIL': '/var/mail/cltbld', 17:21:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:21:52 INFO - 'MOZ_NO_REMOTE': '1', 17:21:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:21:52 INFO - 'NO_EM_RESTART': '1', 17:21:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:21:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:21:52 INFO - 'PWD': '/builds/slave/test', 17:21:52 INFO - 'SHELL': '/bin/bash', 17:21:52 INFO - 'SHLVL': '1', 17:21:52 INFO - 'TERM': 'linux', 17:21:52 INFO - 'TMOUT': '86400', 17:21:52 INFO - 'USER': 'cltbld', 17:21:52 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1472083093.691465-1315008843', 17:21:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:21:52 INFO - '_': '/tools/buildbot/bin/python'} 17:21:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:21: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)) 17:21: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)) 17:21: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)) 17:21: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)) 17:21: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)) 17:21: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)) 17:21: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)) 17:21: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)) 17:21: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)) 17:21: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)) 17:21: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)) 17:21:53 INFO - Cleaning up... 17:21:53 INFO - Return code: 0 17:21:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:21: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')]} 17:21:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:21:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21: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')]} 17:21:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:21:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21: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 0x17df030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9e3b0>, '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 0x1a9f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a9f740>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1472083093.691465-1315008843', '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 17:21: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 17:21: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 17:21:53 INFO - Using env: {'DISPLAY': ':0', 17:21:53 INFO - 'HOME': '/home/cltbld', 17:21:53 INFO - 'LANG': 'en_US.UTF-8', 17:21:53 INFO - 'LANGUAGE': 'en_US:en', 17:21:53 INFO - 'LOGNAME': 'cltbld', 17:21:53 INFO - 'MAIL': '/var/mail/cltbld', 17:21:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:21:53 INFO - 'MOZ_NO_REMOTE': '1', 17:21:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:21:53 INFO - 'NO_EM_RESTART': '1', 17:21:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:21:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:21:53 INFO - 'PWD': '/builds/slave/test', 17:21:53 INFO - 'SHELL': '/bin/bash', 17:21:53 INFO - 'SHLVL': '1', 17:21:53 INFO - 'TERM': 'linux', 17:21:53 INFO - 'TMOUT': '86400', 17:21:53 INFO - 'USER': 'cltbld', 17:21:53 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1472083093.691465-1315008843', 17:21:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:21:53 INFO - '_': '/tools/buildbot/bin/python'} 17:21:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:21:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:21:53 INFO - Cleaning up... 17:21:53 INFO - Return code: 0 17:21:53 INFO - Running post-action listener: _resource_record_post_action 17:21:53 INFO - Running post-action listener: _start_resource_monitoring 17:21:53 INFO - Starting resource monitoring. 17:21:53 INFO - [mozharness: 2016-08-25 00:21:53.356300Z] Finished create-virtualenv step (success) 17:21:53 INFO - [mozharness: 2016-08-25 00:21:53.356733Z] Running install step. 17:21:53 INFO - Running pre-action listener: _resource_record_pre_action 17:21:53 INFO - Running main action method: install 17:21:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:21:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:21:53 INFO - Reading from file tmpfile_stdout 17:21:53 INFO - Detecting whether we're running mozinstall >=1.0... 17:21:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:21:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:21:53 INFO - Reading from file tmpfile_stdout 17:21:53 INFO - Output received: 17:21:53 INFO - Usage: mozinstall [options] installer 17:21:53 INFO - Options: 17:21:53 INFO - -h, --help show this help message and exit 17:21:53 INFO - -d DEST, --destination=DEST 17:21:53 INFO - Directory to install application into. [default: 17:21:53 INFO - "/builds/slave/test"] 17:21:53 INFO - --app=APP Application being installed. [default: firefox] 17:21:53 INFO - mkdir: /builds/slave/test/build/application 17:21: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'] 17:21: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 17:22:10 INFO - Reading from file tmpfile_stdout 17:22:10 INFO - Output received: 17:22:10 INFO - /builds/slave/test/build/application/firefox/firefox 17:22:10 INFO - Running post-action listener: _resource_record_post_action 17:22:10 INFO - [mozharness: 2016-08-25 00:22:10.568748Z] Finished install step (success) 17:22:10 INFO - [mozharness: 2016-08-25 00:22:10.569029Z] Running run-tests step. 17:22:10 INFO - Running pre-action listener: _resource_record_pre_action 17:22:10 INFO - Running main action method: run_tests 17:22:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:22:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:22:10 INFO - Python 2.7.3 17:22:10 INFO - Return code: 0 17:22:10 INFO - grabbing minidump binary from tooltool 17:22: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')]} 17:22: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 0x1a9e3b0>, '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 0x1a9f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a9f740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:22: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 17:22: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 17:22: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 17:22:10 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:22:10 INFO - Return code: 0 17:22:10 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:22:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:22:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:22:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:22:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:22: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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bcmiRztOSyC-Xb4vJQBXKQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 17:22: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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bcmiRztOSyC-Xb4vJQBXKQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-006 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 17:22:10 INFO - Using env: {'DISPLAY': ':0', 17:22:10 INFO - 'HOME': '/home/cltbld', 17:22:10 INFO - 'LANG': 'en_US.UTF-8', 17:22:10 INFO - 'LANGUAGE': 'en_US:en', 17:22:10 INFO - 'LOGNAME': 'cltbld', 17:22:10 INFO - 'MAIL': '/var/mail/cltbld', 17:22:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:22:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:22:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:22:10 INFO - 'MOZ_NO_REMOTE': '1', 17:22:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:22:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:22:10 INFO - 'NO_EM_RESTART': '1', 17:22:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:22:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:22:10 INFO - 'PWD': '/builds/slave/test', 17:22:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:22:10 INFO - 'SHELL': '/bin/bash', 17:22:10 INFO - 'SHLVL': '1', 17:22:10 INFO - 'TERM': 'linux', 17:22:10 INFO - 'TMOUT': '86400', 17:22:10 INFO - 'USER': 'cltbld', 17:22:10 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1472083093.691465-1315008843', 17:22:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:22:10 INFO - '_': '/tools/buildbot/bin/python'} 17:22: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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bcmiRztOSyC-Xb4vJQBXKQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 17:22:10 INFO - mozversion application_buildid: 20160824072526 17:22:10 INFO - mozversion application_changeset: e9da92c75a6933143d43fba52e57cad2a7d9246c 17:22:10 INFO - mozversion application_display_name: FirefoxDeveloperEdition 17:22:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:22:10 INFO - mozversion application_name: Firefox 17:22:10 INFO - mozversion application_remotingname: firefox-dev 17:22:10 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 17:22:10 INFO - mozversion application_vendor: Mozilla 17:22:10 INFO - mozversion application_version: 50.0a2 17:22:10 INFO - mozversion platform_buildid: 20160824072526 17:22:10 INFO - mozversion platform_changeset: e9da92c75a6933143d43fba52e57cad2a7d9246c 17:22:10 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 17:22:10 INFO - mozversion platform_version: 50.0a2 17:22:10 INFO - using testdate: 1472084530 17:22:10 INFO - actual date: 1472084530 17:22:10 INFO - starting webserver on 'localhost:38440' 17:22:10 INFO - SUITE-START | Running 2 tests 17:22:10 INFO - TEST-START | dromaeo_css 17:22:10 INFO - operating with platform_type : linux_ 17:22:10 INFO - Initialising browser for dromaeo_css test... 17:22:10 INFO - TEST-INFO | started process 6552 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSRlnXE/profile http://localhost:38440/getInfo.html) 17:22:14 INFO - PROCESS | 6552 | __metrics Screen width/height:1600/1200 17:22:14 INFO - PROCESS | 6552 | colorDepth:24 17:22:14 INFO - PROCESS | 6552 | Browser inner width/height: 1024/697 17:22:14 INFO - PROCESS | 6552 | __metrics 17:22:15 INFO - PROCESS | 6552 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 17:22:15 INFO - PROCESS | 6552 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:22:16 INFO - TEST-INFO | 6552: exit 0 17:22:16 INFO - Browser initialized. 17:22:16 INFO - Running cycle 1/1 for dromaeo_css test... 17:22:16 INFO - TEST-INFO | started process 6641 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSRlnXE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:22:28 INFO - PROCESS | 6641 | RSS: Main: 145612800 17:22:28 INFO - PROCESS | 6641 | 17:23:19 INFO - PROCESS | 6641 | 1472084599302 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] 17:25:28 INFO - PROCESS | 6641 | Cycle 1(1): loaded http://localhost:38440/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38440/tests/dromaeo/cssquery-ext.html) 17:25:29 INFO - PROCESS | 6641 | RSS: Main: 226250752 17:25:29 INFO - PROCESS | 6641 | 17:28:31 INFO - PROCESS | 6641 | Cycle 1(1): loaded http://localhost:38440/tests/dromaeo/cssquery-ext.html (next: http://localhost:38440/tests/dromaeo/cssquery-jquery.html) 17:28:32 INFO - PROCESS | 6641 | RSS: Main: 236384256 17:28:32 INFO - PROCESS | 6641 | 17:31:34 INFO - PROCESS | 6641 | Cycle 1(1): loaded http://localhost:38440/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38440/tests/dromaeo/cssquery-mootools.html) 17:31:34 INFO - PROCESS | 6641 | RSS: Main: 174563328 17:31:34 INFO - PROCESS | 6641 | 17:34:36 INFO - PROCESS | 6641 | Cycle 1(1): loaded http://localhost:38440/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38440/tests/dromaeo/cssquery-prototype.html) 17:34:37 INFO - PROCESS | 6641 | RSS: Main: 175939584 17:34:37 INFO - PROCESS | 6641 | 17:37:39 INFO - PROCESS | 6641 | Cycle 1(1): loaded http://localhost:38440/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38440/tests/dromaeo/cssquery-yui.html) 17:37:40 INFO - PROCESS | 6641 | RSS: Main: 176971776 17:37:40 INFO - PROCESS | 6641 | 17:40:43 INFO - PROCESS | 6641 | Cycle 1(1): loaded http://localhost:38440/tests/dromaeo/cssquery-yui.html (next: http://localhost:38440/tests/dromaeo/cssquery-dojo.html) 17:40:43 INFO - PROCESS | 6641 | RSS: Main: 259162112 17:40:43 INFO - PROCESS | 6641 | 17:40:43 INFO - PROCESS | 6641 | __start_tp_report 17:40:43 INFO - PROCESS | 6641 | _x_x_mozilla_page_load 17:40:43 INFO - PROCESS | 6641 | _x_x_mozilla_page_load_details 17:40:43 INFO - PROCESS | 6641 | |i|pagename|runs| 17:40:43 INFO - PROCESS | 6641 | |0;dojo.html;3256.218507558186;3266.3140740444505;3266.9346613067723;3271.443854544728;3314.2045908981836;5643.8024669136585;5751.683657398841;5756.510696590784;5775.942240577593;5784.710764461776;5652.265205523277;5693.943060569393;5696.174054762057;5696.344920334162;5701.572382071351;5088.694678319294;5166.560842328407;5169.1987741899875;5215.243789650498;5234.869128271805;5150.04724126036;5219.817306394277;5256.342957130359;5271.578273738091;5271.5782737381105;5160.122779127539;5217.608679349064;5231.398389185235;5249.632525723201;5255.159174532076;5327.946720532784;5335.279737235463;5336.493033161843;5337.839864804062;5366.731663416814;5067.0879241736475;5111.258867464234;5129.512696293846;5225.085610018232;5234;5659.886802263973;5675.772969081232;5705.885882282372;5725.799597014126;5731.369549349568;6170.382961703838;6178.07328900664;6183.041628547582;6186.690665466709;6195.907061394083;6101.298350689639;6134.355892631299;6135.9079613805825;6209.627422354673;6228.159198508189;5796.681182534959;5803.216565763652;5814.825555233349;5815.41845815415;5818.069108942549;5951.196588460502;6354.364563543609;6358.395952384516;6361.045843123568;6361.427471527585;5879.235699359056;5902.822915312548;5907.2911250650195;6010.158577799024;6012;6048.032314829607;6078.665673388006;6080.787172448943;6081.2094427725;6081.756729730761;5931.406859314034;6035.547333949971;6037.9396206038255;6038.547108966845;6040.516758659297;5977.163197152402;5997.16039754426;6035.094735789667;6087.6956152192215;6124.540659450559;4658.417697787777;4681.344611754357;4687.226607609774;4689.343491911135;4728.527147285244;4109.6506796922595;4170.207660544487;4185.727927684691;4198.433211516467;4199.202151591188;5770.826875193751;5818.127280907897;5835.124731290341;5865.149553314745;5904.4095590441475;6212;6216.347283535164;6224;6224.782132625336;6236.158118653923;5673.659580425187;5854.7072646367515;5879.52963762898;5880.411958804086;5885.117232415172;5258.421573626898;5284.445133261029;5307.840764777063;5357.571394288448;5390.21841832932;6358.968205158944;6393.6483493408305;6407.167068281094;6407.583507072025;6411.294757576663;5936.910946335895;6170.660613666291;6175.59858609189;6181.196444462191;6181.5981961174175;6221.657808820558;6264.185655864709;6271.717772700148;6342.841428964312;6348.111264422892;6031.668258245839;6043.395660433922;6046.486048685735;6047.304559975659;6061.515078793774;5943.732532035982;6091.147239386578;6132.110843927695;6148.415900489446;6154.907676384768;5847.678377689268;5940.851478713067;5972.163897054503;6040.788572399945;6081.209442772411;5954.345022047658;5995.91006134917;6002.309734380602;6010;6014.1580178775885;5737.426257374229;5966.164736936746;5971.641701497924;5978.372270911492;5983.252093488314;5945.732442040032;5986.970065149646;6002.159697642421;6031.939680603314;6091.5126789857595;5906.055031194988;5908.084246941731;5911;5917.023691091094;5917.319508256605 17:40:43 INFO - PROCESS | 6641 | |1;ext.html;596.7523477756729;620.4106099205756;627.5983370642789;654.4796886475252;654.6006935769183;35545.82227088864;47674.2848857267;48539.271910921365;48644.75677621611;48686.756566217206;48954.51045489544;49353.50646493534;49385.50614493854;49502.50497495024;49593.752031239885;8543.572821358906;9381.765455863608;9516.71449856502;9547.758791357113;11246.212765106446;11117.110631149488;11508.769824603503;11517.308961462339;11522.423878806068;11522.711932201679;11573.65279041626;11614.36121013344;11621.12841536884;11627.534898604046;11630.12774041946;11425.31448113116;11438.256513326607;11463.312201267867;11491.023263022611;11492.253003554826;11326.660200194008;11378.089752819755;11410.94294528522;11433;11435.199536032482;46462;46637.067258654635;46839.76580117112;46892.5310746895;46964.765176174245;3708.1100535871465;3746.456763769238;3891.8832435026993;4013.1572369802375;4189.874303770892;35967.82016089903;35970;36088;36095;36135.81932090349;4707.058588282357;4761.952380476186;4773.331733557305;4804.399450068741;4852.296417019547;349643;349996;350762;352050.23974880215;353850;36003.81998089993;66058;66484.66757666181;66485.00272495917;66511.66744166249;38311.80844095762;40418.59581404148;40469.59530404717;40508.18983620311;40540.39189412161;17124.229409676343;17229.3969711062;17277.56806079858;17284.22221000058;17293.56766080858;12670;14545.92727036358;14781.33483993223;14804.333804978802;14971.326290316962;9331.860022099674;9340.813183736287;9359.859602105973;9407.811843763224;9423;3483.686468217822;3500.2649443617124;3537.7523573349617;3600.6579374959338;3601.289387540897;1056.186736213127;1068.8236440987305;1074.1836204484491;1089.841972913939;1111.4109521953217;36260.45609315809;36279;36322;36351;36493.27013459716;1158.864312973291;1204.951801927913;1218.4334284557547;1245.1844042152225;1293.5278623302427;18371.90814045948;18758.81241187598;18790.530236743918;18905;19042.80957190438;570859;578437;578937;580435;581542;44029.55970440319;44030.11939761187;44163.337549936776;44352.334714979304;44543.331850022274;1352.5874608244383;1444.1768192130594;1448.3699590677877;1482.8739557137549;1502.9699406012037;35246.64753352536;36637.286378048455;36659.26681466409;36697.50434591476;37052.629473705994;55427;56145.43854561402;56307.15539266833;56374.43625563856;56388.43611563832;433816;435252;435305;435703;435806;30597.23506912345;31728.841355793997;31921.840390797897;32386.35227295488;33410;53358;53705.46294537161;54215.18677219766;54312.18531722106;54791.45208547863;45950.77024614855;46324.30513542367;46666.300005499266;47247.52752472569;48084.5191548094;44841;45040.77479612581;45667.77166114281;46126.30810537777;47477.76261118672;45013;46188.53811461977;46305.768471157426;46320.305195421424;46576.53423465722;39323.606763931995;40504.59495405126;40711.79644101761;40994.38508422316;42151;30163.849180754834;30254.827634111378;30392.848035759678;30423.695763042087;30631.54052689167 17:40:43 INFO - PROCESS | 6641 | |2;jquery.html;395.78825328449284;415.8482154013786;428.8413287083779;431.15708789316886;439.8482523529381;15525.301361438735;19462.41612751618;20894.791052089473;21072.262470813526;21143;19888.303909363174;20185.29351472699;20547.691784623243;20681.172753089897;20851.374458766222;5648.435156484339;5680.460356266159;5884.6174998625165;5890.440408161217;5890.617109887844;5692.829215123553;5842.298924129111;5842.707864606774;5844.853878653025;5847.1521629363715;5578.470045345706;5720.599558030939;5811.593188476808;5825.475707186352;5826.650400975934;5750.884982300351;5784.797532086399;5788.131780232957;5792.044312688422;5792.565557583198;5162.380514338266;5173.094708426011;5213.478652134794;5228.215767634847;5238.449962753894;23919.162829301065;24038.63942040871;24138.637920431207;24244.272671819697;24433.267001989967;2506.448581312127;2562.7181010088875;2580.290420134459;2895.4788138135127;3204.679532046777;15191.848081519265;15210.847891521165;15323.387064517407;15795.526134215992;16035.599110022344;1928.4501177888549;2030.4720772599082;2042.2239548971445;2139.946501337479;2199.7030400895997;78810;78976.60511697462;81583;83918.58040709757;92006.07993919976;10446.320989135682;11261.605843795427;11544.942275288739;11606.187566870238;11787.292762434281;14371;14843.480478183212;15817;15968.76046859298;16044.278007489691;8648.43785153963;8809.911900880908;8813.25402559354;8822.779430514289;8925.464472131693;8659.78350541229;8726.781830454163;8867.778305542284;8917.509536975398;8931.687390941286;4789.928151077736;4843.95156048435;4880.853574392774;4883.755812209375;4963.627727920348;1894.725264836591;1906.428071578521;1907.221120006383;1921.3947606504187;1955.7750858651152;923.533615524156;957.861110139026;1017.196414832289;1064.302881612545;1100.763335882789;18577.44267671972;19238;19613.63307612101;19627.901860490605;20449.18203271882;1005.3113617172114;1020.5662593397776;1021.2953062386929;1030.7732298894232;1062.3307316390624;10537.894621053845;11559.76880462403;11649.825252621218;11659.358735269641;11739.413029348498;234100;515495;521882;524375;524724;64612.67693661502;93790.53104734432;94937.52531237438;97904.51047744715;98450.50774746224;992.6674564021134;1012.1245122968579;1030.7835354575473;1031.6183012285503;1040.432964034603;17476.30094796194;17677.38129165473;18101.45695629133;18403.263869445072;18466.907665461586;44338.77830610827;44478.55521444874;44580.108397831216;46886.29670554876;48988.755056224494;63233.367666322745;63947.36052639414;64424.35575644184;65239.347606523326;65569;8494.83010339802;8621.784455388666;8716.259117975043;8731.738047858575;8812.86780698303;11011.834822477509;13225.537106201236;13508.324583770576;13657.38541765603;13756.724865502834;11822.408879555816;11973.580924667594;12233.449494772578;12478.810408921932;12755.107142499935;12053.156279060382;12303.56937507183;12446.128770985944;12482.75034499323;12608.432620532281;11365.602203922823;11544.59593914209;11763.47064382122;12798.61604151877;12854.16447930919;7886.369090472634;8792.956035219782;8911.2425443838;8977.416467929565;9408.341416100808;11603.883961160618;11754.412279385826;12011.75976480448;12202.60745427531;12523.185992910432 17:40:43 INFO - PROCESS | 6641 | |3;mootools.html;1415.8725714685677;1538.9230538473073;1589.4834178891858;1771.8228177182275;1892.5741708115668;8412.284955778758;9190.954045229773;9394.15452609265;9405.858912116315;9731.124198822105;9497.762555936106;9582.520873956291;9593.376430532027;9597.232221422288;9598.856017159747;2484.838485498446;2513.9120130795427;2517.559427100259;2520.155747824481;2523.570992931197;2460.2127319257843;2562.7693507584313;2564.974350256492;2577.7422257774165;2587.8964841406323;2472.6661900643453;2508.046942161976;2541.313845261778;2545.783608393289;2549.286199864041;2376.346504711201;2383.5947888858936;2386.55848667997;2417.093589903786;2422.4065104049446;2385.6540801583674;2400.0519794681177;2408.0849277274697;2409.71083469983;2450.068973789966;9558.522073896278;9770.853437198448;9801.362911410806;9829.754256143582;9844;5853.356130825606;6007.669578173199;6022.337542870281;6022.96988515059;6029.065494848305;3471.479278108279;3523.330567192251;3536.3104194682046;3543.2204914918675;3582.6059133495296;1157.2246594781516;1162.511745067074;1164.406152862038;1186.7745128425659;2279.168103642175;13514.662133446742;13786.93106534471;14171.433142674281;14232.786508202282;14250.2162381069;5181.948180518147;5184.662996905189;5190.870228244248;5238.319018527567;5309.123994540934;11805.940970295265;11890.583829565923;11895.405229738479;11898.10764192689;11903.166778325434;5924.259467566554;5950.851228719317;5952.136940143655;5956.672383018976;5956.8808623828145;4609.746463944515;4644.303354496852;5266.7366631668265;5341.412444631087;5503.367112782082;4270.829166833292;4273.487181538236;4421.071574969293;4471.329300604935;4490.101979604092;1391.846896841367;1415.985840141606;1418.9716205676036;1420.1479112532604;1432.2122832442114;942.7878727286443;1014.1734486393566;1025.1286406554368;1036.08824234673;1054.583439541377;6363.936360636427;6737.52837301394;6761.526693131532;6767.898481522781;6861.416779573692;451.97288162710345;451.98644040678835;458.3102430841629;475.3297850031439;475.60049558371134;4424;4443.488998765119;4586.8165273388695;4676;4759.643026773006;12016.519339226334;12424.881760641405;12441.502339906483;12559.246445213317;12574.056945729108;11460.713482163013;11809.055275577934;11948.163628545919;12386.071044671686;12412.937935310447;8928.705337725993;9116.772080697903;9148.222401095849;9154.725358239264;9182.908170918205;6728;6851.657417129024;6883.827904302432;6961.930380696128;7024.367806897404;11191.496382662637;11455.255408398427;11509.251898626562;11509.309441433541;11509.827352589551;10406.947965260126;10941.83587246208;11207.551697931991;11443.771124577628;11782.882171178178;8980.326475514494;9402.34183607141;9514.23886089125;9559.23526117895;9577.569009394734;9087.818243635222;9573.856392154263;9577.904220957702;9642;9649.276304277068;8403.243708066304;8405.747827565183;8494.83010339802;8495;8615.181557752003;8344.87482687748;8374.706885259231;8408.2432581068;8409.2431681149;8447.493150410995;8093.554854482824;8103.83792324162;8157.3881958852135;8167.224113709188;8170.101288858102;5579.916301255404;5711.314642242791;5727.513161381163;5799.5070419014855;5838.824835254949;5791.333996590446;5809.680467574155;5892.616979896293;5949.702514874152;5960.284765828128 17:40:43 INFO - PROCESS | 6641 | |4;prototype.html;348.43727380280853;348.799440321815;354.6825591095969;357.43346795329404;359.06642728904853;5484.09512430449;5520.641158324706;5541;5553.361363443205;5582.8325150245455;5462.426445223254;5471;5495.2856128703315;5496.203050557667;5507.449255074491;3818.369968955133;4109.363048727445;4323.870283891489;4324.783760811963;4353.738775673454;4309.353596960465;4323.978380108095;4326.718763280377;4328.329108988112;4339.631131353823;4077.0452660918863;4294.119705460389;4297.419848320468;4297.763623000734;4320.719153255029;4159.939215500043;4269.87190384289;4274.311646899473;4275.957240427587;4297;3806.5812760596314;3806.6764325032404;3807.904802379935;3814.253737309133;3820.178661587772;5272.657277277003;5296.894062118736;5327.840164795062;5344.465553444663;5363;4892.902141957176;4913.729744864031;4918.114739346916;4941.579965702884;4958.504149585049;5645.858853528694;5679.290088738908;5683;5701.9166358392185;5722.685252311121;4081.3061779497557;4216.789160541991;4219.43037689911;4221.134667393208;4239.788010599457;5640.210370548127;5784.623999440023;5950.642961422285;5952.184583701969;5992.580519363646;4290.806913688892;4294.677899157576;4295.613394794484;4296.4414626098405;4297.61321481062;4337.262665346899;4338.436003319548;4342.305231162999;4343.391925130484;4347.782620866163;4765.404324459442;4834.21317990394;4899.632527560448;4900.779464924087;4914.115459217375;5731.048510017345;5746.683932383759;5759.625624334405;5767.567432442584;5772.651861920076;1497.4010395841751;1516.1661086402655;1517.3096241210444;1517.4157949189641;1520.5286361228054;937.4328531238639;986;988.6935050134481;990.5245482168456;1006.8238058339762;4902.28916807061;4916.06594746997;4918.704877707349;4934.322330407678;4941.901161976741;5170.870728231749;5174.223866420067;5179.46206358889;5202.973985130126;5208.84373468789;4568.406107206109;4867.1969125093965;4891.5353041461;4919.926201106986;4939.777710003059;2751.7342022669795;2765.8383478938895;2767.1836808141647;2778.222097812575;2780.8598474625305;5344.839654810362;5348.705821179795;5356.5179133877355;5359.928014397136;5399.649022813504;5244.112119636928;5258.868528286747;5558.610897237236;6001.2498437695285;6085.756569737249;6124.234470691164;6132.816015519452;6141.126956278378;6168.9691551541955;6171.074338849208;5687.800926967537;5965.880682386415;5987.6108052976415;5991.520678345635;6016.608920420159;5860.619059761102;5908.527317814479;5909.734061967136;5916.171735957056;5921.792737254175;5910.970445147746;5995.700214989321;6103.11504831788;6175.752969881154;6211.534134939807;4209.894752631209;4213.32586786125;4219.514755803122;4234.618884300305;4246.108317253412;5779.219805326227;5943.465088142088;5973.402659733992;5978.043513037893;5979.701014949148;5747.885042299215;5787.276590426197;5792.797252096157;5794.594378393472;5801.94198058014;5778.27771528559;5788.363280039108;5789.421057894177;5795.681237531976;5809.738561764815;5585;5739.5695322850115;5754.942450575608;5768.105943578752;5795.478966649521;5794.739236734273;5807.651540907559;5824.475797178275;5850.882982340415;5854.677992710272;5580.888382232251;5692.231548741032;5711.143328500758;5727.1695604138;5744.138379243147 17:40:43 INFO - PROCESS | 6641 | |5;yui.html;809.9068607110185;826.6156237349633;834.8789425533298;840.3991146330376;893.9195472407482;14767.778483322745;15568.22158892055;15671.529854104367;15681.764773528377;15685.686286274267;15989.040657560525;16157;16157.515274541782;16165.43420980266;16180.919095404506;721.1562471907854;839.5550358310074;847.0851480401168;857.3012994409536;860.7848037990502;855.9315254779602;857.2927334948693;857.9613917373733;865.7316231968078;866.4974314897376;911.4986757283501;911.5624500239888;912.4069354919322;912.6212621761961;913.0641092879785;766.3715753082447;901.9413738107035;902.8465160922659;910.1762904571374;914.8947870994854;671.6406722403491;672.744357144282;672.7678950761979;672.7914346552535;672.8418821576926;12088.637340879788;12108.636740897788;12125.393730313537;12145.392730363536;12161.756764864742;14647.194404307758;14868.256587170707;15025.323860426308;15246.161461119635;15257.847421525754;13370.799438008438;13450.461981520728;13530.93234533831;13687.041907066508;14064.507742228972;4691.695039822434;4728.527147285278;4794.161021821167;4832.516748325174;4937.456879743226;84608.15391846064;84674.15325846786;84686;84797.15202847954;85606;11277.041451476553;11467;11528.423578821026;11736.295822250693;11990.280583164864;21819.890900545397;22041.889790550944;22239.777602224094;22257.443563910707;22384.440388990406;8337.833243335099;8408.285295749807;8642.654293828302;8666.393352465268;8814.206721395105;4612;4829.468758436569;4835.927461088087;4970.453250142554;4990.675606085593;3930.4104384342577;4089.6114869087387;4095.1604920991126;4095.9760059985006;4098.672106231495;625.337142628815;731.8353370491596;734.5739471106746;739.803951952733;751.8721817291074;567.7530274330679;676.9932300677028;681.4854784637666;683.9692213850388;706.4136766483806;7939.0870049945;8630.870536941951;9528;9984.650537231308;10025.548850301753;578.9768409263667;638.6370429411197;655.7016557466342;656.0782101147895;672.8015235505537;4476.664250181249;4823.397075365579;4825.1555977703765;4849.248366503198;4849.655694362117;69885;85619.57190214134;106011;129849;137491;87174;109561;112440;112850.43574782074;113562;53872.730636347354;54011.18983215255;54844.17733733997;56298;59568.40431595715;9301.395409298373;9346.859797102912;9387.530623468936;9629.855552166582;9745.658901938397;56013.43986560082;56108.719456402454;56736.716316418155;56912.00807971701;58063.70968145132;67602;71530;73152.63423682848;75204.62397687977;79119;12309.876901230873;12569.622911312676;13236.272005039815;13311.66720831987;13648.454061837416;13598.524051658145;13869.722605548035;14141.505047323295;15231.466898658493;15620.68758624844;13233.404496797475;13261.336933153496;13351.666208344868;13669.384877680726;14729.410823567367;13147.934260328637;13179.472821087049;13842.861571384157;14001;14047.08693934891;13612.591622251348;13732.852633626217;14131.222782746636;14647.487337943121;14655.780163297772;11121.721956951142;11199.88800112021;11818.645440636794;12246.877531224574;12344.259344439362;11546.59586914454;11638;11682.38243017409;11882.524699011943;11944.70138246516 17:40:43 INFO - PROCESS | 6641 | __end_tp_report 17:40:43 INFO - PROCESS | 6641 | __start_cc_report 17:40:43 INFO - PROCESS | 6641 | _x_x_mozilla_cycle_collect,1008 17:40:43 INFO - PROCESS | 6641 | __end_cc_report 17:40:43 INFO - PROCESS | 6641 | __startTimestamp1472085643499__endTimestamp 17:40:43 INFO - PROCESS | 6641 | 17:40:43 INFO - PROCESS | 6641 | ------- Summary: start ------- 17:40:43 INFO - PROCESS | 6641 | Number of tests: 6 17:40:43 INFO - PROCESS | 6641 | 17:40:43 INFO - PROCESS | 6641 | [#0] dojo.html Cycles:165 Average:5693.80 Median:5911.00 stddev:648.61 (11.0%) stddev-sans-first:621.77 17:40:43 INFO - PROCESS | 6641 | Values: 3256.2 3266.3 3266.9 3271.4 3314.2 5643.8 5751.7 5756.5 5775.9 5784.7 5652.3 5693.9 5696.2 5696.3 5701.6 5088.7 5166.6 5169.2 5215.2 5234.9 5150.0 5219.8 5256.3 5271.6 5271.6 5160.1 5217.6 5231.4 5249.6 5255.2 5327.9 5335.3 5336.5 5337.8 5366.7 5067.1 5111.3 5129.5 5225.1 5234.0 5659.9 5675.8 5705.9 5725.8 5731.4 6170.4 6178.1 6183.0 6186.7 6195.9 6101.3 6134.4 6135.9 6209.6 6228.2 5796.7 5803.2 5814.8 5815.4 5818.1 5951.2 6354.4 6358.4 6361.0 6361.4 5879.2 5902.8 5907.3 6010.2 6012.0 6048.0 6078.7 6080.8 6081.2 6081.8 5931.4 6035.5 6037.9 6038.5 6040.5 5977.2 5997.2 6035.1 6087.7 6124.5 4658.4 4681.3 4687.2 4689.3 4728.5 4109.7 4170.2 4185.7 4198.4 4199.2 5770.8 5818.1 5835.1 5865.1 5904.4 6212.0 6216.3 6224.0 6224.8 6236.2 5673.7 5854.7 5879.5 5880.4 5885.1 5258.4 5284.4 5307.8 5357.6 5390.2 6359.0 6393.6 6407.2 6407.6 6411.3 5936.9 6170.7 6175.6 6181.2 6181.6 6221.7 6264.2 6271.7 6342.8 6348.1 6031.7 6043.4 6046.5 6047.3 6061.5 5943.7 6091.1 6132.1 6148.4 6154.9 5847.7 5940.9 5972.2 6040.8 6081.2 5954.3 5995.9 6002.3 6010.0 6014.2 5737.4 5966.2 5971.6 5978.4 5983.3 5945.7 5987.0 6002.2 6031.9 6091.5 5906.1 5908.1 5911.0 5917.0 5917.3 17:40:43 INFO - PROCESS | 6641 | 17:40:43 INFO - PROCESS | 6641 | [#1] ext.html Cycles:180 Average:62329.26 Median:21101.85 stddev:123136.78 (583.5%) stddev-sans-first:123394.98 17:40:43 INFO - PROCESS | 6641 | Values: 596.8 620.4 627.6 654.5 654.6 35545.8 47674.3 48539.3 48644.8 48686.8 48954.5 49353.5 49385.5 49502.5 49593.8 8543.6 9381.8 9516.7 9547.8 11246.2 11117.1 11508.8 11517.3 11522.4 11522.7 11573.7 11614.4 11621.1 11627.5 11630.1 11425.3 11438.3 11463.3 11491.0 11492.3 11326.7 11378.1 11410.9 11433.0 11435.2 46462.0 46637.1 46839.8 46892.5 46964.8 3708.1 3746.5 3891.9 4013.2 4189.9 35967.8 35970.0 36088.0 36095.0 36135.8 4707.1 4762.0 4773.3 4804.4 4852.3 349643.0 349996.0 350762.0 352050.2 353850.0 36003.8 66058.0 66484.7 66485.0 66511.7 38311.8 40418.6 40469.6 40508.2 40540.4 17124.2 17229.4 17277.6 17284.2 17293.6 12670.0 14545.9 14781.3 14804.3 14971.3 9331.9 9340.8 9359.9 9407.8 9423.0 3483.7 3500.3 3537.8 3600.7 3601.3 1056.2 1068.8 1074.2 1089.8 1111.4 36260.5 36279.0 36322.0 36351.0 36493.3 1158.9 1205.0 1218.4 1245.2 1293.5 18371.9 18758.8 18790.5 18905.0 19042.8 570859.0 578437.0 578937.0 580435.0 581542.0 44029.6 44030.1 44163.3 44352.3 44543.3 1352.6 1444.2 1448.4 1482.9 1503.0 35246.6 36637.3 36659.3 36697.5 37052.6 55427.0 56145.4 56307.2 56374.4 56388.4 433816.0 435252.0 435305.0 435703.0 435806.0 30597.2 31728.8 31921.8 32386.4 33410.0 53358.0 53705.5 54215.2 54312.2 54791.5 45950.8 46324.3 46666.3 47247.5 48084.5 44841.0 45040.8 45667.8 46126.3 47477.8 45013.0 46188.5 46305.8 46320.3 46576.5 39323.6 40504.6 40711.8 40994.4 42151.0 30163.8 30254.8 30392.8 30423.7 30631.5 17:40:43 INFO - PROCESS | 6641 | 17:40:43 INFO - PROCESS | 6641 | [#2] jquery.html Cycles:180 Average:28976.29 Median:24191.46 stddev:79094.87 (327.0%) stddev-sans-first:79287.64 17:40:43 INFO - PROCESS | 6641 | Values: 395.8 415.8 428.8 431.2 439.8 15525.3 19462.4 20894.8 21072.3 21143.0 19888.3 20185.3 20547.7 20681.2 20851.4 5648.4 5680.5 5884.6 5890.4 5890.6 5692.8 5842.3 5842.7 5844.9 5847.2 5578.5 5720.6 5811.6 5825.5 5826.7 5750.9 5784.8 5788.1 5792.0 5792.6 5162.4 5173.1 5213.5 5228.2 5238.4 23919.2 24038.6 24138.6 24244.3 24433.3 2506.4 2562.7 2580.3 2895.5 3204.7 15191.8 15210.8 15323.4 15795.5 16035.6 1928.5 2030.5 2042.2 2139.9 2199.7 78810.0 78976.6 81583.0 83918.6 92006.1 10446.3 11261.6 11544.9 11606.2 11787.3 14371.0 14843.5 15817.0 15968.8 16044.3 8648.4 8809.9 8813.3 8822.8 8925.5 8659.8 8726.8 8867.8 8917.5 8931.7 4789.9 4844.0 4880.9 4883.8 4963.6 1894.7 1906.4 1907.2 1921.4 1955.8 923.5 957.9 1017.2 1064.3 1100.8 18577.4 19238.0 19613.6 19627.9 20449.2 1005.3 1020.6 1021.3 1030.8 1062.3 10537.9 11559.8 11649.8 11659.4 11739.4 234100.0 515495.0 521882.0 524375.0 524724.0 64612.7 93790.5 94937.5 97904.5 98450.5 992.7 1012.1 1030.8 1031.6 1040.4 17476.3 17677.4 18101.5 18403.3 18466.9 44338.8 44478.6 44580.1 46886.3 48988.8 63233.4 63947.4 64424.4 65239.3 65569.0 8494.8 8621.8 8716.3 8731.7 8812.9 11011.8 13225.5 13508.3 13657.4 13756.7 11822.4 11973.6 12233.4 12478.8 12755.1 12053.2 12303.6 12446.1 12482.8 12608.4 11365.6 11544.6 11763.5 12798.6 12854.2 7886.4 8793.0 8911.2 8977.4 9408.3 11603.9 11754.4 12011.8 12202.6 12523.2 17:40:43 INFO - PROCESS | 6641 | 17:40:43 INFO - PROCESS | 6641 | [#3] mootools.html Cycles:180 Average:6464.18 Median:4627.02 stddev:3755.11 (81.2%) stddev-sans-first:3746.48 17:40:43 INFO - PROCESS | 6641 | Values: 1415.9 1538.9 1589.5 1771.8 1892.6 8412.3 9191.0 9394.2 9405.9 9731.1 9497.8 9582.5 9593.4 9597.2 9598.9 2484.8 2513.9 2517.6 2520.2 2523.6 2460.2 2562.8 2565.0 2577.7 2587.9 2472.7 2508.0 2541.3 2545.8 2549.3 2376.3 2383.6 2386.6 2417.1 2422.4 2385.7 2400.1 2408.1 2409.7 2450.1 9558.5 9770.9 9801.4 9829.8 9844.0 5853.4 6007.7 6022.3 6023.0 6029.1 3471.5 3523.3 3536.3 3543.2 3582.6 1157.2 1162.5 1164.4 1186.8 2279.2 13514.7 13786.9 14171.4 14232.8 14250.2 5181.9 5184.7 5190.9 5238.3 5309.1 11805.9 11890.6 11895.4 11898.1 11903.2 5924.3 5950.9 5952.1 5956.7 5956.9 4609.7 4644.3 5266.7 5341.4 5503.4 4270.8 4273.5 4421.1 4471.3 4490.1 1391.8 1416.0 1419.0 1420.1 1432.2 942.8 1014.2 1025.1 1036.1 1054.6 6363.9 6737.5 6761.5 6767.9 6861.4 452.0 452.0 458.3 475.3 475.6 4424.0 4443.5 4586.8 4676.0 4759.6 12016.5 12424.9 12441.5 12559.2 12574.1 11460.7 11809.1 11948.2 12386.1 12412.9 8928.7 9116.8 9148.2 9154.7 9182.9 6728.0 6851.7 6883.8 6961.9 7024.4 11191.5 11455.3 11509.3 11509.3 11509.8 10406.9 10941.8 11207.6 11443.8 11782.9 8980.3 9402.3 9514.2 9559.2 9577.6 9087.8 9573.9 9577.9 9642.0 9649.3 8403.2 8405.7 8494.8 8495.0 8615.2 8344.9 8374.7 8408.2 8409.2 8447.5 8093.6 8103.8 8157.4 8167.2 8170.1 5579.9 5711.3 5727.5 5799.5 5838.8 5791.3 5809.7 5892.6 5949.7 5960.3 17:40:43 INFO - PROCESS | 6641 | 17:40:43 INFO - PROCESS | 6641 | [#4] prototype.html Cycles:180 Average:4769.50 Median:5336.15 stddev:1398.73 (26.2%) stddev-sans-first:1362.72 17:40:43 INFO - PROCESS | 6641 | Values: 348.4 348.8 354.7 357.4 359.1 5484.1 5520.6 5541.0 5553.4 5582.8 5462.4 5471.0 5495.3 5496.2 5507.4 3818.4 4109.4 4323.9 4324.8 4353.7 4309.4 4324.0 4326.7 4328.3 4339.6 4077.0 4294.1 4297.4 4297.8 4320.7 4159.9 4269.9 4274.3 4276.0 4297.0 3806.6 3806.7 3807.9 3814.3 3820.2 5272.7 5296.9 5327.8 5344.5 5363.0 4892.9 4913.7 4918.1 4941.6 4958.5 5645.9 5679.3 5683.0 5701.9 5722.7 4081.3 4216.8 4219.4 4221.1 4239.8 5640.2 5784.6 5950.6 5952.2 5992.6 4290.8 4294.7 4295.6 4296.4 4297.6 4337.3 4338.4 4342.3 4343.4 4347.8 4765.4 4834.2 4899.6 4900.8 4914.1 5731.0 5746.7 5759.6 5767.6 5772.7 1497.4 1516.2 1517.3 1517.4 1520.5 937.4 986.0 988.7 990.5 1006.8 4902.3 4916.1 4918.7 4934.3 4941.9 5170.9 5174.2 5179.5 5203.0 5208.8 4568.4 4867.2 4891.5 4919.9 4939.8 2751.7 2765.8 2767.2 2778.2 2780.9 5344.8 5348.7 5356.5 5359.9 5399.6 5244.1 5258.9 5558.6 6001.2 6085.8 6124.2 6132.8 6141.1 6169.0 6171.1 5687.8 5965.9 5987.6 5991.5 6016.6 5860.6 5908.5 5909.7 5916.2 5921.8 5911.0 5995.7 6103.1 6175.8 6211.5 4209.9 4213.3 4219.5 4234.6 4246.1 5779.2 5943.5 5973.4 5978.0 5979.7 5747.9 5787.3 5792.8 5794.6 5801.9 5778.3 5788.4 5789.4 5795.7 5809.7 5585.0 5739.6 5754.9 5768.1 5795.5 5794.7 5807.7 5824.5 5850.9 5854.7 5580.9 5692.2 5711.1 5727.2 5744.1 17:40:43 INFO - PROCESS | 6641 | 17:40:43 INFO - PROCESS | 6641 | [#5] yui.html Cycles:180 Average:20413.38 Median:4830.99 stddev:29234.84 (605.2%) stddev-sans-first:29279.79 17:40:43 INFO - PROCESS | 6641 | Values: 809.9 826.6 834.9 840.4 893.9 14767.8 15568.2 15671.5 15681.8 15685.7 15989.0 16157.0 16157.5 16165.4 16180.9 721.2 839.6 847.1 857.3 860.8 855.9 857.3 858.0 865.7 866.5 911.5 911.6 912.4 912.6 913.1 766.4 901.9 902.8 910.2 914.9 671.6 672.7 672.8 672.8 672.8 12088.6 12108.6 12125.4 12145.4 12161.8 14647.2 14868.3 15025.3 15246.2 15257.8 13370.8 13450.5 13530.9 13687.0 14064.5 4691.7 4728.5 4794.2 4832.5 4937.5 84608.2 84674.2 84686.0 84797.2 85606.0 11277.0 11467.0 11528.4 11736.3 11990.3 21819.9 22041.9 22239.8 22257.4 22384.4 8337.8 8408.3 8642.7 8666.4 8814.2 4612.0 4829.5 4835.9 4970.5 4990.7 3930.4 4089.6 4095.2 4096.0 4098.7 625.3 731.8 734.6 739.8 751.9 567.8 677.0 681.5 684.0 706.4 7939.1 8630.9 9528.0 9984.7 10025.5 579.0 638.6 655.7 656.1 672.8 4476.7 4823.4 4825.2 4849.2 4849.7 69885.0 85619.6 106011.0 129849.0 137491.0 87174.0 109561.0 112440.0 112850.4 113562.0 53872.7 54011.2 54844.2 56298.0 59568.4 9301.4 9346.9 9387.5 9629.9 9745.7 56013.4 56108.7 56736.7 56912.0 58063.7 67602.0 71530.0 73152.6 75204.6 79119.0 12309.9 12569.6 13236.3 13311.7 13648.5 13598.5 13869.7 14141.5 15231.5 15620.7 13233.4 13261.3 13351.7 13669.4 14729.4 13147.9 13179.5 13842.9 14001.0 14047.1 13612.6 13732.9 14131.2 14647.5 14655.8 11121.7 11199.9 11818.6 12246.9 12344.3 11546.6 11638.0 11682.4 11882.5 11944.7 17:40:43 INFO - PROCESS | 6641 | -------- Summary: end -------- 17:40:43 INFO - PROCESS | 6641 | 17:40:44 INFO - TEST-INFO | 6641: exit 0 17:40:44 INFO - TEST-OK | dromaeo_css | took 1113349ms 17:40:44 INFO - TEST-START | kraken 17:40:44 INFO - operating with platform_type : linux_ 17:40:44 INFO - Initialising browser for kraken test... 17:40:44 INFO - TEST-INFO | started process 6844 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxwDrwI/profile http://localhost:38440/getInfo.html) 17:40:48 INFO - PROCESS | 6844 | __metrics Screen width/height:1600/1200 17:40:48 INFO - PROCESS | 6844 | colorDepth:24 17:40:48 INFO - PROCESS | 6844 | Browser inner width/height: 1024/697 17:40:48 INFO - PROCESS | 6844 | __metrics 17:40:48 INFO - PROCESS | 6844 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 17:40:48 INFO - PROCESS | 6844 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:40:49 INFO - TEST-INFO | 6844: exit 0 17:40:49 INFO - Browser initialized. 17:40:49 INFO - Running cycle 1/1 for kraken test... 17:40:49 INFO - TEST-INFO | started process 6936 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxwDrwI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:41:01 INFO - PROCESS | 6936 | RSS: Main: 145387520 17:41:01 INFO - PROCESS | 6936 | 17:41:04 INFO - PROCESS | 6936 | Cycle 1(1): loaded http://localhost:38440/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38440/tests/kraken/driver.html?testName=audio-beat-detection) 17:41:04 INFO - PROCESS | 6936 | RSS: Main: 191549440 17:41:04 INFO - PROCESS | 6936 | 17:41:07 INFO - PROCESS | 6936 | Cycle 1(1): loaded http://localhost:38440/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38440/tests/kraken/driver.html?testName=audio-dft) 17:41:08 INFO - PROCESS | 6936 | RSS: Main: 181071872 17:41:08 INFO - PROCESS | 6936 | 17:41:10 INFO - PROCESS | 6936 | Cycle 1(1): loaded http://localhost:38440/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38440/tests/kraken/driver.html?testName=audio-fft) 17:41:11 INFO - PROCESS | 6936 | RSS: Main: 269955072 17:41:11 INFO - PROCESS | 6936 | 17:41:13 INFO - PROCESS | 6936 | Cycle 1(1): loaded http://localhost:38440/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38440/tests/kraken/driver.html?testName=audio-oscillator) 17:41:14 INFO - PROCESS | 6936 | RSS: Main: 175808512 17:41:14 INFO - PROCESS | 6936 | 17:41:16 INFO - PROCESS | 6936 | Cycle 1(1): loaded http://localhost:38440/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38440/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:41:16 INFO - PROCESS | 6936 | RSS: Main: 177352704 17:41:16 INFO - PROCESS | 6936 | 17:41:19 INFO - PROCESS | 6936 | Cycle 1(1): loaded http://localhost:38440/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38440/tests/kraken/driver.html?testName=imaging-darkroom) 17:41:20 INFO - PROCESS | 6936 | RSS: Main: 213422080 17:41:20 INFO - PROCESS | 6936 | 17:41:23 INFO - PROCESS | 6936 | Cycle 1(1): loaded http://localhost:38440/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38440/tests/kraken/driver.html?testName=imaging-desaturate) 17:41:24 INFO - PROCESS | 6936 | RSS: Main: 212066304 17:41:24 INFO - PROCESS | 6936 | 17:41:27 INFO - PROCESS | 6936 | Cycle 1(1): loaded http://localhost:38440/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38440/tests/kraken/driver.html?testName=json-parse-financial) 17:41:27 INFO - PROCESS | 6936 | RSS: Main: 211742720 17:41:27 INFO - PROCESS | 6936 | 17:41:29 INFO - PROCESS | 6936 | Cycle 1(1): loaded http://localhost:38440/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38440/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:41:29 INFO - PROCESS | 6936 | RSS: Main: 176148480 17:41:29 INFO - PROCESS | 6936 | 17:41:31 INFO - PROCESS | 6936 | Cycle 1(1): loaded http://localhost:38440/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38440/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:41:32 INFO - PROCESS | 6936 | RSS: Main: 182108160 17:41:32 INFO - PROCESS | 6936 | 17:41:34 INFO - PROCESS | 6936 | Cycle 1(1): loaded http://localhost:38440/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38440/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:41:34 INFO - PROCESS | 6936 | RSS: Main: 186327040 17:41:34 INFO - PROCESS | 6936 | 17:41:37 INFO - PROCESS | 6936 | Cycle 1(1): loaded http://localhost:38440/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38440/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:41:37 INFO - PROCESS | 6936 | RSS: Main: 181760000 17:41:37 INFO - PROCESS | 6936 | 17:41:40 INFO - PROCESS | 6936 | Cycle 1(1): loaded http://localhost:38440/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38440/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:41:41 INFO - PROCESS | 6936 | RSS: Main: 185155584 17:41:41 INFO - PROCESS | 6936 | 17:41:42 INFO - PROCESS | 6936 | Cycle 1(1): loaded http://localhost:38440/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38440/tests/kraken/driver.html?testName=ai-astar) 17:41:42 INFO - PROCESS | 6936 | RSS: Main: 236310528 17:41:42 INFO - PROCESS | 6936 | 17:41:42 INFO - PROCESS | 6936 | __start_tp_report 17:41:42 INFO - PROCESS | 6936 | _x_x_mozilla_page_load 17:41:42 INFO - PROCESS | 6936 | _x_x_mozilla_page_load_details 17:41:42 INFO - PROCESS | 6936 | |i|pagename|runs| 17:41:42 INFO - PROCESS | 6936 | |0;ai-astar;102;112;111;110;112;113;109;112;110;111 17:41:42 INFO - PROCESS | 6936 | |1;audio-beat-detection;140;115;117;170;117;116;138;114;148;115 17:41:42 INFO - PROCESS | 6936 | |2;audio-dft;161;161;159;159;161;161;159;159;160;159 17:41:42 INFO - PROCESS | 6936 | |3;audio-fft;75;75;74;107;76;77;74;74;101;74 17:41:42 INFO - PROCESS | 6936 | |4;audio-oscillator;83;83;126;84;84;83;128;83;83;135 17:41:42 INFO - PROCESS | 6936 | |5;imaging-gaussian-blur;117;116;116;117;116;117;117;117;116;117 17:41:42 INFO - PROCESS | 6936 | |6;imaging-darkroom;145;145;145;145;146;146;146;145;146;146 17:41:42 INFO - PROCESS | 6936 | |7;imaging-desaturate;94;94;95;94;94;94;94;94;94;95 17:41:42 INFO - PROCESS | 6936 | |8;json-parse-financial;50;51;51;51;50;52;52;51;51;50 17:41:42 INFO - PROCESS | 6936 | |9;json-stringify-tinderbox;60;61;62;61;60;61;59;60;60;61 17:41:42 INFO - PROCESS | 6936 | |10;stanford-crypto-aes;73;75;73;72;73;72;73;73;73;73 17:41:42 INFO - PROCESS | 6936 | |11;stanford-crypto-ccm;118;119;118;124;115;117;116;117;149;120 17:41:42 INFO - PROCESS | 6936 | |12;stanford-crypto-pbkdf2;159;154;156;157;154;153;156;157;152;153 17:41:42 INFO - PROCESS | 6936 | |13;stanford-crypto-sha256-iterative;63;63;66;61;62;63;62;65;63;62 17:41:42 INFO - PROCESS | 6936 | __end_tp_report 17:41:42 INFO - PROCESS | 6936 | __start_cc_report 17:41:42 INFO - PROCESS | 6936 | _x_x_mozilla_cycle_collect,1649 17:41:42 INFO - PROCESS | 6936 | __end_cc_report 17:41:42 INFO - PROCESS | 6936 | __startTimestamp1472085702871__endTimestamp 17:41:42 INFO - PROCESS | 6936 | 17:41:42 INFO - PROCESS | 6936 | ------- Summary: start ------- 17:41:42 INFO - PROCESS | 6936 | Number of tests: 14 17:41:42 INFO - PROCESS | 6936 | 17:41:42 INFO - PROCESS | 6936 | [#0] ai-astar Cycles:10 Average:110.20 Median:111.50 stddev:3.12 (2.8%) stddev-sans-first:1.27 17:41:42 INFO - PROCESS | 6936 | Values: 102.0 112.0 111.0 110.0 112.0 113.0 109.0 112.0 110.0 111.0 17:41:42 INFO - PROCESS | 6936 | 17:41:42 INFO - PROCESS | 6936 | [#1] audio-beat-detection Cycles:10 Average:129.00 Median:127.50 stddev:19.20 (15.1%) stddev-sans-first:19.95 17:41:42 INFO - PROCESS | 6936 | Values: 140.0 115.0 117.0 170.0 117.0 116.0 138.0 114.0 148.0 115.0 17:41:42 INFO - PROCESS | 6936 | 17:41:42 INFO - PROCESS | 6936 | [#2] audio-dft Cycles:10 Average:159.90 Median:160.50 stddev:0.99 (0.6%) stddev-sans-first:0.97 17:41:42 INFO - PROCESS | 6936 | Values: 161.0 161.0 159.0 159.0 161.0 161.0 159.0 159.0 160.0 159.0 17:41:42 INFO - PROCESS | 6936 | 17:41:42 INFO - PROCESS | 6936 | [#3] audio-fft Cycles:10 Average:80.70 Median:74.50 stddev:12.40 (16.6%) stddev-sans-first:12.98 17:41:42 INFO - PROCESS | 6936 | Values: 75.0 75.0 74.0 107.0 76.0 77.0 74.0 74.0 101.0 74.0 17:41:42 INFO - PROCESS | 6936 | 17:41:42 INFO - PROCESS | 6936 | [#4] audio-oscillator Cycles:10 Average:97.20 Median:83.00 stddev:22.52 (27.1%) stddev-sans-first:23.29 17:41:42 INFO - PROCESS | 6936 | Values: 83.0 83.0 126.0 84.0 84.0 83.0 128.0 83.0 83.0 135.0 17:41:42 INFO - PROCESS | 6936 | 17:41:42 INFO - PROCESS | 6936 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 17:41:42 INFO - PROCESS | 6936 | Values: 117.0 116.0 116.0 117.0 116.0 117.0 117.0 117.0 116.0 117.0 17:41:42 INFO - PROCESS | 6936 | 17:41:42 INFO - PROCESS | 6936 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 17:41:42 INFO - PROCESS | 6936 | Values: 145.0 145.0 145.0 145.0 146.0 146.0 146.0 145.0 146.0 146.0 17:41:42 INFO - PROCESS | 6936 | 17:41:42 INFO - PROCESS | 6936 | [#7] imaging-desaturate Cycles:10 Average:94.20 Median:94.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 17:41:42 INFO - PROCESS | 6936 | Values: 94.0 94.0 95.0 94.0 94.0 94.0 94.0 94.0 94.0 95.0 17:41:42 INFO - PROCESS | 6936 | 17:41:42 INFO - PROCESS | 6936 | [#8] json-parse-financial Cycles:10 Average:50.90 Median:51.00 stddev:0.74 (1.4%) stddev-sans-first:0.71 17:41:42 INFO - PROCESS | 6936 | Values: 50.0 51.0 51.0 51.0 50.0 52.0 52.0 51.0 51.0 50.0 17:41:42 INFO - PROCESS | 6936 | 17:41:42 INFO - PROCESS | 6936 | [#9] json-stringify-tinderbox Cycles:10 Average:60.50 Median:61.00 stddev:0.85 (1.4%) stddev-sans-first:0.88 17:41:42 INFO - PROCESS | 6936 | Values: 60.0 61.0 62.0 61.0 60.0 61.0 59.0 60.0 60.0 61.0 17:41:42 INFO - PROCESS | 6936 | 17:41:42 INFO - PROCESS | 6936 | [#10] stanford-crypto-aes Cycles:10 Average:73.00 Median:73.00 stddev:0.82 (1.1%) stddev-sans-first:0.87 17:41:42 INFO - PROCESS | 6936 | Values: 73.0 75.0 73.0 72.0 73.0 72.0 73.0 73.0 73.0 73.0 17:41:42 INFO - PROCESS | 6936 | 17:41:42 INFO - PROCESS | 6936 | [#11] stanford-crypto-ccm Cycles:10 Average:121.30 Median:118.50 stddev:10.04 (8.5%) stddev-sans-first:10.58 17:41:42 INFO - PROCESS | 6936 | Values: 118.0 119.0 118.0 124.0 115.0 117.0 116.0 117.0 149.0 120.0 17:41:42 INFO - PROCESS | 6936 | 17:41:42 INFO - PROCESS | 6936 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.10 Median:156.00 stddev:2.23 (1.4%) stddev-sans-first:1.87 17:41:42 INFO - PROCESS | 6936 | Values: 159.0 154.0 156.0 157.0 154.0 153.0 156.0 157.0 152.0 153.0 17:41:42 INFO - PROCESS | 6936 | 17:41:42 INFO - PROCESS | 6936 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.00 Median:63.00 stddev:1.49 (2.4%) stddev-sans-first:1.58 17:41:42 INFO - PROCESS | 6936 | Values: 63.0 63.0 66.0 61.0 62.0 63.0 62.0 65.0 63.0 62.0 17:41:42 INFO - PROCESS | 6936 | -------- Summary: end -------- 17:41:42 INFO - PROCESS | 6936 | 17:41:43 INFO - TEST-INFO | 6936: exit 0 17:41:44 INFO - TEST-OK | kraken | took 59819ms 17:41:44 INFO - SUITE-END | took 1173s 17:41:44 INFO - Completed test suite (00:19:33) 17:41:44 INFO - javascript benchmark 17:41:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3256.218507558186, 3266.3140740444505, 3266.9346613067723, 3271.443854544728, 3314.2045908981836, 5643.8024669136585, 5751.683657398841, 5756.510696590784, 5775.942240577593, 5784.710764461776, 5652.265205523277, 5693.943060569393, 5696.174054762057, 5696.344920334162, 5701.572382071351, 5088.694678319294, 5166.560842328407, 5169.1987741899875, 5215.243789650498, 5234.869128271805, 5150.04724126036, 5219.817306394277, 5256.342957130359, 5271.578273738091, 5271.5782737381105, 5160.122779127539, 5217.608679349064, 5231.398389185235, 5249.632525723201, 5255.159174532076, 5327.946720532784, 5335.279737235463, 5336.493033161843, 5337.839864804062, 5366.731663416814, 5067.0879241736475, 5111.258867464234, 5129.512696293846, 5225.085610018232, 5234.0, 5659.886802263973, 5675.772969081232, 5705.885882282372, 5725.799597014126, 5731.369549349568, 6170.382961703838, 6178.07328900664, 6183.041628547582, 6186.690665466709, 6195.907061394083, 6101.298350689639, 6134.355892631299, 6135.9079613805825, 6209.627422354673, 6228.159198508189, 5796.681182534959, 5803.216565763652, 5814.825555233349, 5815.41845815415, 5818.069108942549, 5951.196588460502, 6354.364563543609, 6358.395952384516, 6361.045843123568, 6361.427471527585, 5879.235699359056, 5902.822915312548, 5907.2911250650195, 6010.158577799024, 6012.0, 6048.032314829607, 6078.665673388006, 6080.787172448943, 6081.2094427725, 6081.756729730761, 5931.406859314034, 6035.547333949971, 6037.9396206038255, 6038.547108966845, 6040.516758659297, 5977.163197152402, 5997.16039754426, 6035.094735789667, 6087.6956152192215, 6124.540659450559, 4658.417697787777, 4681.344611754357, 4687.226607609774, 4689.343491911135, 4728.527147285244, 4109.6506796922595, 4170.207660544487, 4185.727927684691, 4198.433211516467, 4199.202151591188, 5770.826875193751, 5818.127280907897, 5835.124731290341, 5865.149553314745, 5904.4095590441475, 6212.0, 6216.347283535164, 6224.0, 6224.782132625336, 6236.158118653923, 5673.659580425187, 5854.7072646367515, 5879.52963762898, 5880.411958804086, 5885.117232415172, 5258.421573626898, 5284.445133261029, 5307.840764777063, 5357.571394288448, 5390.21841832932, 6358.968205158944, 6393.6483493408305, 6407.167068281094, 6407.583507072025, 6411.294757576663, 5936.910946335895, 6170.660613666291, 6175.59858609189, 6181.196444462191, 6181.5981961174175, 6221.657808820558, 6264.185655864709, 6271.717772700148, 6342.841428964312, 6348.111264422892, 6031.668258245839, 6043.395660433922, 6046.486048685735, 6047.304559975659, 6061.515078793774, 5943.732532035982, 6091.147239386578, 6132.110843927695, 6148.415900489446, 6154.907676384768, 5847.678377689268, 5940.851478713067, 5972.163897054503, 6040.788572399945, 6081.209442772411, 5954.345022047658, 5995.91006134917, 6002.309734380602, 6010.0, 6014.1580178775885, 5737.426257374229, 5966.164736936746, 5971.641701497924, 5978.372270911492, 5983.252093488314, 5945.732442040032, 5986.970065149646, 6002.159697642421, 6031.939680603314, 6091.5126789857595, 5906.055031194988, 5908.084246941731, 5911.0, 5917.023691091094, 5917.319508256605], "value": 5649.489133225341, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [596.7523477756729, 620.4106099205756, 627.5983370642789, 654.4796886475252, 654.6006935769183, 35545.82227088864, 47674.2848857267, 48539.271910921365, 48644.75677621611, 48686.756566217206, 48954.51045489544, 49353.50646493534, 49385.50614493854, 49502.50497495024, 49593.752031239885, 8543.572821358906, 9381.765455863608, 9516.71449856502, 9547.758791357113, 11246.212765106446, 11117.110631149488, 11508.769824603503, 11517.308961462339, 11522.423878806068, 11522.711932201679, 11573.65279041626, 11614.36121013344, 11621.12841536884, 11627.534898604046, 11630.12774041946, 11425.31448113116, 11438.256513326607, 11463.312201267867, 11491.023263022611, 11492.253003554826, 11326.660200194008, 11378.089752819755, 11410.94294528522, 11433.0, 11435.199536032482, 46462.0, 46637.067258654635, 46839.76580117112, 46892.5310746895, 46964.765176174245, 3708.1100535871465, 3746.456763769238, 3891.8832435026993, 4013.1572369802375, 4189.874303770892, 35967.82016089903, 35970.0, 36088.0, 36095.0, 36135.81932090349, 4707.058588282357, 4761.952380476186, 4773.331733557305, 4804.399450068741, 4852.296417019547, 349643.0, 349996.0, 350762.0, 352050.23974880215, 353850.0, 36003.81998089993, 66058.0, 66484.66757666181, 66485.00272495917, 66511.66744166249, 38311.80844095762, 40418.59581404148, 40469.59530404717, 40508.18983620311, 40540.39189412161, 17124.229409676343, 17229.3969711062, 17277.56806079858, 17284.22221000058, 17293.56766080858, 12670.0, 14545.92727036358, 14781.33483993223, 14804.333804978802, 14971.326290316962, 9331.860022099674, 9340.813183736287, 9359.859602105973, 9407.811843763224, 9423.0, 3483.686468217822, 3500.2649443617124, 3537.7523573349617, 3600.6579374959338, 3601.289387540897, 1056.186736213127, 1068.8236440987305, 1074.1836204484491, 1089.841972913939, 1111.4109521953217, 36260.45609315809, 36279.0, 36322.0, 36351.0, 36493.27013459716, 1158.864312973291, 1204.951801927913, 1218.4334284557547, 1245.1844042152225, 1293.5278623302427, 18371.90814045948, 18758.81241187598, 18790.530236743918, 18905.0, 19042.80957190438, 570859.0, 578437.0, 578937.0, 580435.0, 581542.0, 44029.55970440319, 44030.11939761187, 44163.337549936776, 44352.334714979304, 44543.331850022274, 1352.5874608244383, 1444.1768192130594, 1448.3699590677877, 1482.8739557137549, 1502.9699406012037, 35246.64753352536, 36637.286378048455, 36659.26681466409, 36697.50434591476, 37052.629473705994, 55427.0, 56145.43854561402, 56307.15539266833, 56374.43625563856, 56388.43611563832, 433816.0, 435252.0, 435305.0, 435703.0, 435806.0, 30597.23506912345, 31728.841355793997, 31921.840390797897, 32386.35227295488, 33410.0, 53358.0, 53705.46294537161, 54215.18677219766, 54312.18531722106, 54791.45208547863, 45950.77024614855, 46324.30513542367, 46666.300005499266, 47247.52752472569, 48084.5191548094, 44841.0, 45040.77479612581, 45667.77166114281, 46126.30810537777, 47477.76261118672, 45013.0, 46188.53811461977, 46305.768471157426, 46320.305195421424, 46576.53423465722, 39323.606763931995, 40504.59495405126, 40711.79644101761, 40994.38508422316, 42151.0, 30163.849180754834, 30254.827634111378, 30392.848035759678, 30423.695763042087, 30631.54052689167], "value": 20893.975409538187, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [395.78825328449284, 415.8482154013786, 428.8413287083779, 431.15708789316886, 439.8482523529381, 15525.301361438735, 19462.41612751618, 20894.791052089473, 21072.262470813526, 21143.0, 19888.303909363174, 20185.29351472699, 20547.691784623243, 20681.172753089897, 20851.374458766222, 5648.435156484339, 5680.460356266159, 5884.6174998625165, 5890.440408161217, 5890.617109887844, 5692.829215123553, 5842.298924129111, 5842.707864606774, 5844.853878653025, 5847.1521629363715, 5578.470045345706, 5720.599558030939, 5811.593188476808, 5825.475707186352, 5826.650400975934, 5750.884982300351, 5784.797532086399, 5788.131780232957, 5792.044312688422, 5792.565557583198, 5162.380514338266, 5173.094708426011, 5213.478652134794, 5228.215767634847, 5238.449962753894, 23919.162829301065, 24038.63942040871, 24138.637920431207, 24244.272671819697, 24433.267001989967, 2506.448581312127, 2562.7181010088875, 2580.290420134459, 2895.4788138135127, 3204.679532046777, 15191.848081519265, 15210.847891521165, 15323.387064517407, 15795.526134215992, 16035.599110022344, 1928.4501177888549, 2030.4720772599082, 2042.2239548971445, 2139.946501337479, 2199.7030400895997, 78810.0, 78976.60511697462, 81583.0, 83918.58040709757, 92006.07993919976, 10446.320989135682, 11261.605843795427, 11544.942275288739, 11606.187566870238, 11787.292762434281, 14371.0, 14843.480478183212, 15817.0, 15968.76046859298, 16044.278007489691, 8648.43785153963, 8809.911900880908, 8813.25402559354, 8822.779430514289, 8925.464472131693, 8659.78350541229, 8726.781830454163, 8867.778305542284, 8917.509536975398, 8931.687390941286, 4789.928151077736, 4843.95156048435, 4880.853574392774, 4883.755812209375, 4963.627727920348, 1894.725264836591, 1906.428071578521, 1907.221120006383, 1921.3947606504187, 1955.7750858651152, 923.533615524156, 957.861110139026, 1017.196414832289, 1064.302881612545, 1100.763335882789, 18577.44267671972, 19238.0, 19613.63307612101, 19627.901860490605, 20449.18203271882, 1005.3113617172114, 1020.5662593397776, 1021.2953062386929, 1030.7732298894232, 1062.3307316390624, 10537.894621053845, 11559.76880462403, 11649.825252621218, 11659.358735269641, 11739.413029348498, 234100.0, 515495.0, 521882.0, 524375.0, 524724.0, 64612.67693661502, 93790.53104734432, 94937.52531237438, 97904.51047744715, 98450.50774746224, 992.6674564021134, 1012.1245122968579, 1030.7835354575473, 1031.6183012285503, 1040.432964034603, 17476.30094796194, 17677.38129165473, 18101.45695629133, 18403.263869445072, 18466.907665461586, 44338.77830610827, 44478.55521444874, 44580.108397831216, 46886.29670554876, 48988.755056224494, 63233.367666322745, 63947.36052639414, 64424.35575644184, 65239.347606523326, 65569.0, 8494.83010339802, 8621.784455388666, 8716.259117975043, 8731.738047858575, 8812.86780698303, 11011.834822477509, 13225.537106201236, 13508.324583770576, 13657.38541765603, 13756.724865502834, 11822.408879555816, 11973.580924667594, 12233.449494772578, 12478.810408921932, 12755.107142499935, 12053.156279060382, 12303.56937507183, 12446.128770985944, 12482.75034499323, 12608.432620532281, 11365.602203922823, 11544.59593914209, 11763.47064382122, 12798.61604151877, 12854.16447930919, 7886.369090472634, 8792.956035219782, 8911.2425443838, 8977.416467929565, 9408.341416100808, 11603.883961160618, 11754.412279385826, 12011.75976480448, 12202.60745427531, 12523.185992910432], "value": 9629.332607306203, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1415.8725714685677, 1538.9230538473073, 1589.4834178891858, 1771.8228177182275, 1892.5741708115668, 8412.284955778758, 9190.954045229773, 9394.15452609265, 9405.858912116315, 9731.124198822105, 9497.762555936106, 9582.520873956291, 9593.376430532027, 9597.232221422288, 9598.856017159747, 2484.838485498446, 2513.9120130795427, 2517.559427100259, 2520.155747824481, 2523.570992931197, 2460.2127319257843, 2562.7693507584313, 2564.974350256492, 2577.7422257774165, 2587.8964841406323, 2472.6661900643453, 2508.046942161976, 2541.313845261778, 2545.783608393289, 2549.286199864041, 2376.346504711201, 2383.5947888858936, 2386.55848667997, 2417.093589903786, 2422.4065104049446, 2385.6540801583674, 2400.0519794681177, 2408.0849277274697, 2409.71083469983, 2450.068973789966, 9558.522073896278, 9770.853437198448, 9801.362911410806, 9829.754256143582, 9844.0, 5853.356130825606, 6007.669578173199, 6022.337542870281, 6022.96988515059, 6029.065494848305, 3471.479278108279, 3523.330567192251, 3536.3104194682046, 3543.2204914918675, 3582.6059133495296, 1157.2246594781516, 1162.511745067074, 1164.406152862038, 1186.7745128425659, 2279.168103642175, 13514.662133446742, 13786.93106534471, 14171.433142674281, 14232.786508202282, 14250.2162381069, 5181.948180518147, 5184.662996905189, 5190.870228244248, 5238.319018527567, 5309.123994540934, 11805.940970295265, 11890.583829565923, 11895.405229738479, 11898.10764192689, 11903.166778325434, 5924.259467566554, 5950.851228719317, 5952.136940143655, 5956.672383018976, 5956.8808623828145, 4609.746463944515, 4644.303354496852, 5266.7366631668265, 5341.412444631087, 5503.367112782082, 4270.829166833292, 4273.487181538236, 4421.071574969293, 4471.329300604935, 4490.101979604092, 1391.846896841367, 1415.985840141606, 1418.9716205676036, 1420.1479112532604, 1432.2122832442114, 942.7878727286443, 1014.1734486393566, 1025.1286406554368, 1036.08824234673, 1054.583439541377, 6363.936360636427, 6737.52837301394, 6761.526693131532, 6767.898481522781, 6861.416779573692, 451.97288162710345, 451.98644040678835, 458.3102430841629, 475.3297850031439, 475.60049558371134, 4424.0, 4443.488998765119, 4586.8165273388695, 4676.0, 4759.643026773006, 12016.519339226334, 12424.881760641405, 12441.502339906483, 12559.246445213317, 12574.056945729108, 11460.713482163013, 11809.055275577934, 11948.163628545919, 12386.071044671686, 12412.937935310447, 8928.705337725993, 9116.772080697903, 9148.222401095849, 9154.725358239264, 9182.908170918205, 6728.0, 6851.657417129024, 6883.827904302432, 6961.930380696128, 7024.367806897404, 11191.496382662637, 11455.255408398427, 11509.251898626562, 11509.309441433541, 11509.827352589551, 10406.947965260126, 10941.83587246208, 11207.551697931991, 11443.771124577628, 11782.882171178178, 8980.326475514494, 9402.34183607141, 9514.23886089125, 9559.23526117895, 9577.569009394734, 9087.818243635222, 9573.856392154263, 9577.904220957702, 9642.0, 9649.276304277068, 8403.243708066304, 8405.747827565183, 8494.83010339802, 8495.0, 8615.181557752003, 8344.87482687748, 8374.706885259231, 8408.2432581068, 8409.2431681149, 8447.493150410995, 8093.554854482824, 8103.83792324162, 8157.3881958852135, 8167.224113709188, 8170.101288858102, 5579.916301255404, 5711.314642242791, 5727.513161381163, 5799.5070419014855, 5838.824835254949, 5791.333996590446, 5809.680467574155, 5892.616979896293, 5949.702514874152, 5960.284765828128], "value": 5037.241386415002, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.43727380280853, 348.799440321815, 354.6825591095969, 357.43346795329404, 359.06642728904853, 5484.09512430449, 5520.641158324706, 5541.0, 5553.361363443205, 5582.8325150245455, 5462.426445223254, 5471.0, 5495.2856128703315, 5496.203050557667, 5507.449255074491, 3818.369968955133, 4109.363048727445, 4323.870283891489, 4324.783760811963, 4353.738775673454, 4309.353596960465, 4323.978380108095, 4326.718763280377, 4328.329108988112, 4339.631131353823, 4077.0452660918863, 4294.119705460389, 4297.419848320468, 4297.763623000734, 4320.719153255029, 4159.939215500043, 4269.87190384289, 4274.311646899473, 4275.957240427587, 4297.0, 3806.5812760596314, 3806.6764325032404, 3807.904802379935, 3814.253737309133, 3820.178661587772, 5272.657277277003, 5296.894062118736, 5327.840164795062, 5344.465553444663, 5363.0, 4892.902141957176, 4913.729744864031, 4918.114739346916, 4941.579965702884, 4958.504149585049, 5645.858853528694, 5679.290088738908, 5683.0, 5701.9166358392185, 5722.685252311121, 4081.3061779497557, 4216.789160541991, 4219.43037689911, 4221.134667393208, 4239.788010599457, 5640.210370548127, 5784.623999440023, 5950.642961422285, 5952.184583701969, 5992.580519363646, 4290.806913688892, 4294.677899157576, 4295.613394794484, 4296.4414626098405, 4297.61321481062, 4337.262665346899, 4338.436003319548, 4342.305231162999, 4343.391925130484, 4347.782620866163, 4765.404324459442, 4834.21317990394, 4899.632527560448, 4900.779464924087, 4914.115459217375, 5731.048510017345, 5746.683932383759, 5759.625624334405, 5767.567432442584, 5772.651861920076, 1497.4010395841751, 1516.1661086402655, 1517.3096241210444, 1517.4157949189641, 1520.5286361228054, 937.4328531238639, 986.0, 988.6935050134481, 990.5245482168456, 1006.8238058339762, 4902.28916807061, 4916.06594746997, 4918.704877707349, 4934.322330407678, 4941.901161976741, 5170.870728231749, 5174.223866420067, 5179.46206358889, 5202.973985130126, 5208.84373468789, 4568.406107206109, 4867.1969125093965, 4891.5353041461, 4919.926201106986, 4939.777710003059, 2751.7342022669795, 2765.8383478938895, 2767.1836808141647, 2778.222097812575, 2780.8598474625305, 5344.839654810362, 5348.705821179795, 5356.5179133877355, 5359.928014397136, 5399.649022813504, 5244.112119636928, 5258.868528286747, 5558.610897237236, 6001.2498437695285, 6085.756569737249, 6124.234470691164, 6132.816015519452, 6141.126956278378, 6168.9691551541955, 6171.074338849208, 5687.800926967537, 5965.880682386415, 5987.6108052976415, 5991.520678345635, 6016.608920420159, 5860.619059761102, 5908.527317814479, 5909.734061967136, 5916.171735957056, 5921.792737254175, 5910.970445147746, 5995.700214989321, 6103.11504831788, 6175.752969881154, 6211.534134939807, 4209.894752631209, 4213.32586786125, 4219.514755803122, 4234.618884300305, 4246.108317253412, 5779.219805326227, 5943.465088142088, 5973.402659733992, 5978.043513037893, 5979.701014949148, 5747.885042299215, 5787.276590426197, 5792.797252096157, 5794.594378393472, 5801.94198058014, 5778.27771528559, 5788.363280039108, 5789.421057894177, 5795.681237531976, 5809.738561764815, 5585.0, 5739.5695322850115, 5754.942450575608, 5768.105943578752, 5795.478966649521, 5794.739236734273, 5807.651540907559, 5824.475797178275, 5850.882982340415, 5854.677992710272, 5580.888382232251, 5692.231548741032, 5711.143328500758, 5727.1695604138, 5744.138379243147], "value": 4330.841344513333, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [809.9068607110185, 826.6156237349633, 834.8789425533298, 840.3991146330376, 893.9195472407482, 14767.778483322745, 15568.22158892055, 15671.529854104367, 15681.764773528377, 15685.686286274267, 15989.040657560525, 16157.0, 16157.515274541782, 16165.43420980266, 16180.919095404506, 721.1562471907854, 839.5550358310074, 847.0851480401168, 857.3012994409536, 860.7848037990502, 855.9315254779602, 857.2927334948693, 857.9613917373733, 865.7316231968078, 866.4974314897376, 911.4986757283501, 911.5624500239888, 912.4069354919322, 912.6212621761961, 913.0641092879785, 766.3715753082447, 901.9413738107035, 902.8465160922659, 910.1762904571374, 914.8947870994854, 671.6406722403491, 672.744357144282, 672.7678950761979, 672.7914346552535, 672.8418821576926, 12088.637340879788, 12108.636740897788, 12125.393730313537, 12145.392730363536, 12161.756764864742, 14647.194404307758, 14868.256587170707, 15025.323860426308, 15246.161461119635, 15257.847421525754, 13370.799438008438, 13450.461981520728, 13530.93234533831, 13687.041907066508, 14064.507742228972, 4691.695039822434, 4728.527147285278, 4794.161021821167, 4832.516748325174, 4937.456879743226, 84608.15391846064, 84674.15325846786, 84686.0, 84797.15202847954, 85606.0, 11277.041451476553, 11467.0, 11528.423578821026, 11736.295822250693, 11990.280583164864, 21819.890900545397, 22041.889790550944, 22239.777602224094, 22257.443563910707, 22384.440388990406, 8337.833243335099, 8408.285295749807, 8642.654293828302, 8666.393352465268, 8814.206721395105, 4612.0, 4829.468758436569, 4835.927461088087, 4970.453250142554, 4990.675606085593, 3930.4104384342577, 4089.6114869087387, 4095.1604920991126, 4095.9760059985006, 4098.672106231495, 625.337142628815, 731.8353370491596, 734.5739471106746, 739.803951952733, 751.8721817291074, 567.7530274330679, 676.9932300677028, 681.4854784637666, 683.9692213850388, 706.4136766483806, 7939.0870049945, 8630.870536941951, 9528.0, 9984.650537231308, 10025.548850301753, 578.9768409263667, 638.6370429411197, 655.7016557466342, 656.0782101147895, 672.8015235505537, 4476.664250181249, 4823.397075365579, 4825.1555977703765, 4849.248366503198, 4849.655694362117, 69885.0, 85619.57190214134, 106011.0, 129849.0, 137491.0, 87174.0, 109561.0, 112440.0, 112850.43574782074, 113562.0, 53872.730636347354, 54011.18983215255, 54844.17733733997, 56298.0, 59568.40431595715, 9301.395409298373, 9346.859797102912, 9387.530623468936, 9629.855552166582, 9745.658901938397, 56013.43986560082, 56108.719456402454, 56736.716316418155, 56912.00807971701, 58063.70968145132, 67602.0, 71530.0, 73152.63423682848, 75204.62397687977, 79119.0, 12309.876901230873, 12569.622911312676, 13236.272005039815, 13311.66720831987, 13648.454061837416, 13598.524051658145, 13869.722605548035, 14141.505047323295, 15231.466898658493, 15620.68758624844, 13233.404496797475, 13261.336933153496, 13351.666208344868, 13669.384877680726, 14729.410823567367, 13147.934260328637, 13179.472821087049, 13842.861571384157, 14001.0, 14047.08693934891, 13612.591622251348, 13732.852633626217, 14131.222782746636, 14647.487337943121, 14655.780163297772, 11121.721956951142, 11199.88800112021, 11818.645440636794, 12246.877531224574, 12344.259344439362, 11546.59586914454, 11638.0, 11682.38243017409, 11882.524699011943, 11944.70138246516], "value": 7698.060552984046, "unit": "score"}], "name": "dromaeo_css", "value": 7588.148902293541, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 112.0, 111.0, 110.0, 112.0, 113.0, 109.0, 112.0, 110.0, 111.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 115.0, 117.0, 170.0, 117.0, 116.0, 138.0, 114.0, 148.0, 115.0], "value": 129.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 159.0, 159.0, 161.0, 161.0, 159.0, 159.0, 160.0, 159.0], "value": 159.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 74.0, 107.0, 76.0, 77.0, 74.0, 74.0, 101.0, 74.0], "value": 80.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 126.0, 84.0, 84.0, 83.0, 128.0, 83.0, 83.0, 135.0], "value": 97.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 145.0, 145.0, 146.0, 146.0, 146.0, 145.0, 146.0, 146.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 95.0], "value": 94.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 51.0, 51.0, 51.0, 50.0, 52.0, 52.0, 51.0, 51.0, 50.0], "value": 50.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 62.0, 61.0, 60.0, 61.0, 59.0, 60.0, 60.0, 61.0], "value": 60.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 73.0, 72.0, 73.0, 72.0, 73.0, 73.0, 73.0, 73.0], "value": 73.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 119.0, 118.0, 124.0, 115.0, 117.0, 116.0, 117.0, 149.0, 120.0], "value": 121.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 154.0, 156.0, 157.0, 154.0, 153.0, 156.0, 157.0, 152.0, 153.0], "value": 155.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 66.0, 61.0, 62.0, 63.0, 62.0, 65.0, 63.0, 62.0], "value": 63.0, "unit": "score"}], "name": "kraken", "value": 1457.1, "alertThreshold": 2.0}]} 17:41:44 INFO - Return code: 0 17:41:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:41:44 INFO - # TBPL SUCCESS # 17:41:44 INFO - Running post-action listener: _resource_record_post_action 17:41:44 INFO - [mozharness: 2016-08-25 00:41:44.204930Z] Finished run-tests step (success) 17:41:44 INFO - Running post-run listener: _resource_record_post_run 17:41:44 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 458752; Write bytes: 329752576; Read time: 72; Write time: 366136 17:41:44 INFO - TinderboxPrint: CPU usage
12.9% 17:41:44 INFO - TinderboxPrint: I/O read bytes / time
458,752 / 72 17:41:44 INFO - TinderboxPrint: I/O write bytes / time
329,752,576 / 366,136 17:41:44 INFO - TinderboxPrint: CPU idle
8,268.0 (87.0%) 17:41:44 INFO - TinderboxPrint: CPU user
1,183.2 (12.5%) 17:41:44 INFO - TinderboxPrint: Swap in / out
0 / 0 17:41:44 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 79179776; Read time: 0; Write time: 143580 17:41:44 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 454656; Write bytes: 250179584; Read time: 64; Write time: 222472 17:41:44 INFO - Running post-run listener: _upload_blobber_files 17:41:44 INFO - Blob upload gear active. 17:41:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:41:44 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 17:41:44 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'] 17:41:44 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 17:41:45 INFO - (blobuploader) - INFO - Open directory for files ... 17:41:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:41:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:41:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:41:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:41:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:41:48 INFO - (blobuploader) - INFO - Done attempting. 17:41:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:41:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:41:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:41:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:41:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:41:49 INFO - (blobuploader) - INFO - Done attempting. 17:41:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:41:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:41:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:41:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:41:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:41:50 INFO - (blobuploader) - INFO - Done attempting. 17:41:50 INFO - (blobuploader) - INFO - Iteration through files over. 17:41:50 INFO - Return code: 0 17:41:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:41:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:41:50 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/da161dff6bb2dfeb261a43299675f9310668ad4df9bd734113a9e997c051c34639fb9dc703cdf3b817e74a044c3f372325982b550c26242e8ddbab4ee362d72e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9a2226bfed8ea48eb373a8b9ee30654dea6aa250e5138b0e5aeed1295682fcaf8e51c3895654263314cbfaa6dc28ad928681eb58d3107ca855c0b85f2ee01650", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dffe234e65919bb39e56e13064ff661a36e96cd7850394b41fb8e83cbccb1ac29e93ae816f83cc27de3ade236f67c153dd940d5518574827a2c201876a5c3bb0"} 17:41:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:41:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:41:50 INFO - Contents: 17:41:50 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/da161dff6bb2dfeb261a43299675f9310668ad4df9bd734113a9e997c051c34639fb9dc703cdf3b817e74a044c3f372325982b550c26242e8ddbab4ee362d72e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9a2226bfed8ea48eb373a8b9ee30654dea6aa250e5138b0e5aeed1295682fcaf8e51c3895654263314cbfaa6dc28ad928681eb58d3107ca855c0b85f2ee01650", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dffe234e65919bb39e56e13064ff661a36e96cd7850394b41fb8e83cbccb1ac29e93ae816f83cc27de3ade236f67c153dd940d5518574827a2c201876a5c3bb0"} 17:41:50 INFO - Running post-run listener: copy_logs_to_upload_dir 17:41:50 INFO - Copying logs to upload dir... 17:41:50 INFO - mkdir: /builds/slave/test/build/upload/logs 17:41:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1678.720620 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 58 secs) (at 2016-08-24 17:41:50.509906) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-24 17:41:50.514413) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1472083093.691465-1315008843 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/da161dff6bb2dfeb261a43299675f9310668ad4df9bd734113a9e997c051c34639fb9dc703cdf3b817e74a044c3f372325982b550c26242e8ddbab4ee362d72e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9a2226bfed8ea48eb373a8b9ee30654dea6aa250e5138b0e5aeed1295682fcaf8e51c3895654263314cbfaa6dc28ad928681eb58d3107ca855c0b85f2ee01650", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dffe234e65919bb39e56e13064ff661a36e96cd7850394b41fb8e83cbccb1ac29e93ae816f83cc27de3ade236f67c153dd940d5518574827a2c201876a5c3bb0"} build_url:https://queue.taskcluster.net/v1/task/bcmiRztOSyC-Xb4vJQBXKQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011332 build_url: 'https://queue.taskcluster.net/v1/task/bcmiRztOSyC-Xb4vJQBXKQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/da161dff6bb2dfeb261a43299675f9310668ad4df9bd734113a9e997c051c34639fb9dc703cdf3b817e74a044c3f372325982b550c26242e8ddbab4ee362d72e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9a2226bfed8ea48eb373a8b9ee30654dea6aa250e5138b0e5aeed1295682fcaf8e51c3895654263314cbfaa6dc28ad928681eb58d3107ca855c0b85f2ee01650", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dffe234e65919bb39e56e13064ff661a36e96cd7850394b41fb8e83cbccb1ac29e93ae816f83cc27de3ade236f67c153dd940d5518574827a2c201876a5c3bb0"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-24 17:41:50.543653) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 17:41:50.544020) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1472083093.691465-1315008843 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004524 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 17:41:50.624697) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-24 17:41:50.625309) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-24 17:41:50.626014) ========= ========= Total master_lag: 0.20 =========