builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0120 starttime: 1462797327.76 results: success (0) buildid: 20160509005545 builduid: ea7a7eff58c544d79701ff562c295d6e revision: fc51f034e4aca08b76934a832d7dc7db1954b9d2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-09 05:35:27.758264) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-09 05:35:27.759179) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-09 05:35:27.759851) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-09 05:35:27.779662) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 05:35:27.779951) ========= 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: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.kS6Wx5JK3f/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.QabMDETVzg/Listeners TMPDIR=/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-05-09 05:35:27-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 175M=0s 2016-05-09 05:35:27 (175 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.083956 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 05:35:27.880827) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 05:35:27.881139) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.kS6Wx5JK3f/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.QabMDETVzg/Listeners TMPDIR=/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.027823 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 05:35:27.929336) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-05-09 05:35:27.929695) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev fc51f034e4aca08b76934a832d7dc7db1954b9d2 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev fc51f034e4aca08b76934a832d7dc7db1954b9d2 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.kS6Wx5JK3f/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.QabMDETVzg/Listeners TMPDIR=/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-05-09 05:35:27,998 truncating revision to first 12 chars 2016-05-09 05:35:27,998 Setting DEBUG logging. 2016-05-09 05:35:27,998 attempt 1/10 2016-05-09 05:35:27,998 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/fc51f034e4ac?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-09 05:35:29,779 unpacking tar archive at: mozilla-beta-fc51f034e4ac/testing/mozharness/ program finished with exit code 0 elapsedTime=2.031797 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-05-09 05:35:29.978558) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-09 05:35:29.978882) ========= script_repo_revision: fc51f034e4aca08b76934a832d7dc7db1954b9d2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-09 05:35:29.979366) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-09 05:35:29.979684) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-09 05:35:29.993412) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-05-09 05:35:29.993693) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.kS6Wx5JK3f/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.QabMDETVzg/Listeners TMPDIR=/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 05:35:30 INFO - MultiFileLogger online at 20160509 05:35:30 in /builds/slave/test 05:35:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 05:35:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:35:30 INFO - {'append_to_log': False, 05:35:30 INFO - 'base_work_dir': '/builds/slave/test', 05:35:30 INFO - 'blob_upload_branch': 'Mozilla-Beta', 05:35:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:35:30 INFO - 'branch': 'Mozilla-Beta', 05:35:30 INFO - 'buildbot_json_path': 'buildprops.json', 05:35:30 INFO - 'config_files': ('talos/mac_config.py',), 05:35:30 INFO - 'default_actions': ('clobber', 05:35:30 INFO - 'read-buildbot-config', 05:35:30 INFO - 'download-and-extract', 05:35:30 INFO - 'populate-webroot', 05:35:30 INFO - 'create-virtualenv', 05:35:30 INFO - 'install', 05:35:30 INFO - 'run-tests'), 05:35:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:35:30 INFO - 'download_minidump_stackwalk': True, 05:35:30 INFO - 'download_symbols': 'ondemand', 05:35:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:35:30 INFO - 'tooltool.py': '/tools/tooltool.py', 05:35:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:35:30 INFO - '/tools/misc-python/virtualenv.py')}, 05:35:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:35:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:35:30 INFO - 'installer_path': 'installer.exe', 05:35:30 INFO - 'log_level': 'info', 05:35:30 INFO - 'log_name': 'talos', 05:35:30 INFO - 'log_to_console': True, 05:35:30 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:35:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:35:30 INFO - 'opt_config_files': (), 05:35:30 INFO - 'pip_index': False, 05:35:30 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:35:30 INFO - 'cmd': ('bash', 05:35:30 INFO - '-c', 05:35:30 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:35:30 INFO - 'enabled': True, 05:35:30 INFO - 'halt_on_failure': False, 05:35:30 INFO - 'name': 'check_screen_resolution'},), 05:35:30 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:35:30 INFO - 'cmd': ('bash', 05:35:30 INFO - '-c', 05:35:30 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:35:30 INFO - 'enabled': True, 05:35:30 INFO - 'halt_on_failure': False, 05:35:30 INFO - 'name': 'check_screen_resolution'},), 05:35:30 INFO - 'run_cmd_checks_enabled': True, 05:35:30 INFO - 'sps_profile': False, 05:35:30 INFO - 'sps_profile_interval': 0, 05:35:30 INFO - 'suite': 'dromaeojs-e10s', 05:35:30 INFO - 'system_bits': '32', 05:35:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:35:30 INFO - 'title': 't-yosemite-r7-0120', 05:35:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:35:30 INFO - 'use_talos_json': True, 05:35:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:35:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:35:30 INFO - 'work_dir': 'build'} 05:35:30 INFO - ##### 05:35:30 INFO - ##### Running clobber step. 05:35:30 INFO - ##### 05:35:30 INFO - Running pre-action listener: _resource_record_pre_action 05:35:30 INFO - Running main action method: clobber 05:35:30 INFO - rmtree: /builds/slave/test/build 05:35:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:35:32 INFO - Running post-action listener: _resource_record_post_action 05:35:32 INFO - ##### 05:35:32 INFO - ##### Running read-buildbot-config step. 05:35:32 INFO - ##### 05:35:32 INFO - Running pre-action listener: _resource_record_pre_action 05:35:32 INFO - Running main action method: read_buildbot_config 05:35:32 INFO - Using buildbot properties: 05:35:32 INFO - { 05:35:32 INFO - "project": "", 05:35:32 INFO - "product": "firefox", 05:35:32 INFO - "script_repo_revision": "production", 05:35:32 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 05:35:32 INFO - "repository": "", 05:35:32 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 05:35:32 INFO - "buildid": "20160509005545", 05:35:32 INFO - "pgo_build": "False", 05:35:32 INFO - "basedir": "/builds/slave/test", 05:35:32 INFO - "buildnumber": 78, 05:35:32 INFO - "slavename": "t-yosemite-r7-0120", 05:35:32 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 05:35:32 INFO - "platform": "yosemite_r7", 05:35:32 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 05:35:32 INFO - "branch": "mozilla-beta", 05:35:32 INFO - "repo_path": "releases/mozilla-beta", 05:35:32 INFO - "revision": "fc51f034e4aca08b76934a832d7dc7db1954b9d2", 05:35:32 INFO - "stage_platform": "macosx64", 05:35:32 INFO - "builduid": "ea7a7eff58c544d79701ff562c295d6e", 05:35:32 INFO - "slavebuilddir": "test" 05:35:32 INFO - } 05:35:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/D_vUHmeKR_2mA7juCS2aMw/artifacts/public/build/firefox-47.0.en-US.mac.dmg. 05:35:32 INFO - Running post-action listener: _resource_record_post_action 05:35:32 INFO - ##### 05:35:32 INFO - ##### Running download-and-extract step. 05:35:32 INFO - ##### 05:35:32 INFO - Running pre-action listener: _resource_record_pre_action 05:35:32 INFO - Running main action method: download_and_extract 05:35:32 INFO - mkdir: /builds/slave/test/build/tests 05:35:32 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')]} 05:35:32 INFO - https://queue.taskcluster.net/v1/task/D_vUHmeKR_2mA7juCS2aMw/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 05:35:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D_vUHmeKR_2mA7juCS2aMw/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json 05:35:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D_vUHmeKR_2mA7juCS2aMw/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json 05:35:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D_vUHmeKR_2mA7juCS2aMw/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json 05:35:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D_vUHmeKR_2mA7juCS2aMw/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json'}, attempt #1 05:35:33 INFO - Downloaded 1241 bytes. 05:35:33 INFO - Reading from file /builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json 05:35:33 INFO - Using the following test package requirements: 05:35:33 INFO - {u'common': [u'firefox-47.0.en-US.mac.common.tests.zip'], 05:35:33 INFO - u'cppunittest': [u'firefox-47.0.en-US.mac.common.tests.zip', 05:35:33 INFO - u'firefox-47.0.en-US.mac.cppunittest.tests.zip'], 05:35:33 INFO - u'gtest': [u'firefox-47.0.en-US.mac.common.tests.zip', 05:35:33 INFO - u'firefox-47.0.en-US.mac.gtest.tests.zip'], 05:35:33 INFO - u'jittest': [u'firefox-47.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 05:35:33 INFO - u'mochitest': [u'firefox-47.0.en-US.mac.common.tests.zip', 05:35:33 INFO - u'firefox-47.0.en-US.mac.mochitest.tests.zip'], 05:35:33 INFO - u'mozbase': [u'firefox-47.0.en-US.mac.common.tests.zip'], 05:35:33 INFO - u'reftest': [u'firefox-47.0.en-US.mac.common.tests.zip', 05:35:33 INFO - u'firefox-47.0.en-US.mac.reftest.tests.zip'], 05:35:33 INFO - u'talos': [u'firefox-47.0.en-US.mac.common.tests.zip', 05:35:33 INFO - u'firefox-47.0.en-US.mac.talos.tests.zip'], 05:35:33 INFO - u'web-platform': [u'firefox-47.0.en-US.mac.common.tests.zip', 05:35:33 INFO - u'firefox-47.0.en-US.mac.web-platform.tests.zip'], 05:35:33 INFO - u'webapprt': [u'firefox-47.0.en-US.mac.common.tests.zip'], 05:35:33 INFO - u'xpcshell': [u'firefox-47.0.en-US.mac.common.tests.zip', 05:35:33 INFO - u'firefox-47.0.en-US.mac.xpcshell.tests.zip']} 05:35:33 INFO - Downloading packages: [u'firefox-47.0.en-US.mac.common.tests.zip'] for test suite category: common 05:35:33 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')]} 05:35:33 INFO - https://queue.taskcluster.net/v1/task/D_vUHmeKR_2mA7juCS2aMw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:35:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D_vUHmeKR_2mA7juCS2aMw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 05:35:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D_vUHmeKR_2mA7juCS2aMw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 05:35:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D_vUHmeKR_2mA7juCS2aMw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip 05:35:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D_vUHmeKR_2mA7juCS2aMw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip'}, attempt #1 05:35:34 INFO - Downloaded 17747440 bytes. 05:35:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:35:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:35:37 INFO - Return code: 0 05:35:37 INFO - Downloading packages: [u'firefox-47.0.en-US.mac.common.tests.zip', u'firefox-47.0.en-US.mac.talos.tests.zip'] for test suite category: talos 05:35: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')]} 05:35:37 INFO - https://queue.taskcluster.net/v1/task/D_vUHmeKR_2mA7juCS2aMw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:35:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D_vUHmeKR_2mA7juCS2aMw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 05:35:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D_vUHmeKR_2mA7juCS2aMw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 05:35:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D_vUHmeKR_2mA7juCS2aMw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip 05:35:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D_vUHmeKR_2mA7juCS2aMw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip'}, attempt #1 05:35:39 INFO - Downloaded 17747440 bytes. 05:35:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:35:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:35:42 INFO - Return code: 0 05:35: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')]} 05:35:42 INFO - https://queue.taskcluster.net/v1/task/D_vUHmeKR_2mA7juCS2aMw/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 05:35:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D_vUHmeKR_2mA7juCS2aMw/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 05:35:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D_vUHmeKR_2mA7juCS2aMw/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 05:35:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D_vUHmeKR_2mA7juCS2aMw/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip 05:35:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D_vUHmeKR_2mA7juCS2aMw/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip'}, attempt #1 05:35:44 INFO - Downloaded 10845194 bytes. 05:35:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:35:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 05:35:44 INFO - Return code: 0 05:35:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:35:44 INFO - https://queue.taskcluster.net/v1/task/D_vUHmeKR_2mA7juCS2aMw/artifacts/public/build/firefox-47.0.en-US.mac.dmg matches https://queue.taskcluster.net 05:35:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D_vUHmeKR_2mA7juCS2aMw/artifacts/public/build/firefox-47.0.en-US.mac.dmg 05:35:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D_vUHmeKR_2mA7juCS2aMw/artifacts/public/build/firefox-47.0.en-US.mac.dmg 05:35:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D_vUHmeKR_2mA7juCS2aMw/artifacts/public/build/firefox-47.0.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0.en-US.mac.dmg 05:35:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D_vUHmeKR_2mA7juCS2aMw/artifacts/public/build/firefox-47.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.mac.dmg'}, attempt #1 05:35:47 INFO - Downloaded 88341384 bytes. 05:35:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/D_vUHmeKR_2mA7juCS2aMw/artifacts/public/build/firefox-47.0.en-US.mac.dmg 05:35:47 INFO - mkdir: /builds/slave/test/properties 05:35:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:35:47 INFO - Writing to file /builds/slave/test/properties/build_url 05:35:47 INFO - Contents: 05:35:47 INFO - build_url:https://queue.taskcluster.net/v1/task/D_vUHmeKR_2mA7juCS2aMw/artifacts/public/build/firefox-47.0.en-US.mac.dmg 05:35:48 INFO - Running post-action listener: _resource_record_post_action 05:35:48 INFO - Running post-action listener: set_extra_try_arguments 05:35:48 INFO - ##### 05:35:48 INFO - ##### Running populate-webroot step. 05:35:48 INFO - ##### 05:35:48 INFO - Running pre-action listener: _resource_record_pre_action 05:35:48 INFO - Running main action method: populate_webroot 05:35:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:35:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:35:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:35:48 INFO - '--tppagecycles', 05:35:48 INFO - '7'], 05:35:48 INFO - 'tests': ['tsvgm']}}, 05:35:48 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:35:48 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:35:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:35:48 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 05:35:48 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:35:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:35:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:35:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:48 INFO - 'talos_options': ['--e10s'], 05:35:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:35:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:48 INFO - 'tests': ['damp', 'tps']}, 05:35:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:48 INFO - 'talos_options': ['--e10s'], 05:35:48 INFO - 'tests': ['damp', 'tps']}, 05:35:48 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:35:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:35:48 INFO - 'other': {'tests': ['a11yr', 05:35:48 INFO - 'ts_paint', 05:35:48 INFO - 'tpaint', 05:35:48 INFO - 'sessionrestore', 05:35:48 INFO - 'sessionrestore_no_auto_restore', 05:35:48 INFO - 'tabpaint']}, 05:35:48 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:35:48 INFO - 'tests': ['a11yr', 05:35:48 INFO - 'ts_paint', 05:35:48 INFO - 'tpaint', 05:35:48 INFO - 'sessionrestore', 05:35:48 INFO - 'sessionrestore_no_auto_restore', 05:35:48 INFO - 'tabpaint']}, 05:35:48 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:35:48 INFO - 'tests': ['a11yr', 05:35:48 INFO - 'ts_paint', 05:35:48 INFO - 'tpaint', 05:35:48 INFO - 'sessionrestore', 05:35:48 INFO - 'sessionrestore_no_auto_restore', 05:35:48 INFO - 'tabpaint']}, 05:35:48 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:35:48 INFO - 'tests': ['a11yr', 05:35:48 INFO - 'ts_paint', 05:35:48 INFO - 'tpaint', 05:35:48 INFO - 'sessionrestore', 05:35:48 INFO - 'sessionrestore_no_auto_restore', 05:35:48 INFO - 'tabpaint']}, 05:35:48 INFO - 'other_l64': {'tests': ['a11yr', 05:35:48 INFO - 'ts_paint', 05:35:48 INFO - 'tpaint', 05:35:48 INFO - 'sessionrestore', 05:35:48 INFO - 'sessionrestore_no_auto_restore', 05:35:48 INFO - 'tabpaint']}, 05:35:48 INFO - 'other_nol64': {'tests': ['a11yr', 05:35:48 INFO - 'ts_paint', 05:35:48 INFO - 'tpaint', 05:35:48 INFO - 'sessionrestore', 05:35:48 INFO - 'sessionrestore_no_auto_restore', 05:35:48 INFO - 'tabpaint']}, 05:35:48 INFO - 'svgr': {'tests': ['tsvgx', 05:35:48 INFO - 'tsvgr_opacity', 05:35:48 INFO - 'tart', 05:35:48 INFO - 'tscrollx', 05:35:48 INFO - 'cart']}, 05:35:48 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:35:48 INFO - 'tests': ['tsvgx', 05:35:48 INFO - 'tsvgr_opacity', 05:35:48 INFO - 'tart', 05:35:48 INFO - 'tscrollx', 05:35:48 INFO - 'cart']}, 05:35:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:48 INFO - 'tests': ['tp5o']}, 05:35:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:48 INFO - 'talos_options': ['--e10s'], 05:35:48 INFO - 'tests': ['tp5o']}, 05:35:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:48 INFO - 'talos_options': ['--xperf_path', 05:35:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:35:48 INFO - 'tests': ['tp5n']}, 05:35:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:48 INFO - 'talos_options': ['--e10s', 05:35:48 INFO - '--xperf_path', 05:35:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:35:48 INFO - 'tests': ['tp5n']}}, 05:35:48 INFO - 'talos.zip': {'path': '', 05:35:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:35:48 INFO - Running post-action listener: _resource_record_post_action 05:35:48 INFO - ##### 05:35:48 INFO - ##### Running create-virtualenv step. 05:35:48 INFO - ##### 05:35:48 INFO - Running pre-action listener: _resource_record_pre_action 05:35:48 INFO - Running main action method: create_virtualenv 05:35:48 INFO - Creating virtualenv /builds/slave/test/build/venv 05:35:48 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 05:35:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:35:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:35:48 INFO - Using real prefix '/tools/python27' 05:35:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:35:49 INFO - Installing distribute.............................................................................................................................................................................................done. 05:35:52 INFO - Installing pip.................done. 05:35:52 INFO - Return code: 0 05:35:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:35: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')]} 05:35:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:35:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35: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')]} 05:35:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:35:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:52 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 0x10cb65a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cb6c4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd32b48c9f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca09d30>, '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 0x10c86ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ca00b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kS6Wx5JK3f/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QabMDETVzg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:35:52 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 05:35:52 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 05:35:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kS6Wx5JK3f/Render', 05:35:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:35:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:35:52 INFO - 'HOME': '/Users/cltbld', 05:35:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:35:52 INFO - 'LOGNAME': 'cltbld', 05:35:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:35:52 INFO - 'MOZ_NO_REMOTE': '1', 05:35:52 INFO - 'NO_EM_RESTART': '1', 05:35:52 INFO - 'PAGER': '/bin/cat', 05:35:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:35:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:35:52 INFO - 'PWD': '/builds/slave/test', 05:35:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:35:52 INFO - 'SHELL': '/bin/bash', 05:35:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QabMDETVzg/Listeners', 05:35:52 INFO - 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/', 05:35:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:35:52 INFO - 'USER': 'cltbld', 05:35:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:35:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:35:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:35:52 INFO - 'XPC_FLAGS': '0x0', 05:35:52 INFO - 'XPC_SERVICE_NAME': '0', 05:35:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:35:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:35:52 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 05:35:52 INFO - Cleaning up... 05:35:52 INFO - Return code: 0 05:35:52 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:35: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')]} 05:35:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:35:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35: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')]} 05:35:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:35:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:52 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>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10cb65a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cb6c4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd32b48c9f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca09d30>, '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 0x10c86ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ca00b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kS6Wx5JK3f/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QabMDETVzg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:35:52 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>=0.7.1'] in /builds/slave/test/build 05:35:52 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>=0.7.1 05:35:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kS6Wx5JK3f/Render', 05:35:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:35:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:35:52 INFO - 'HOME': '/Users/cltbld', 05:35:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:35:52 INFO - 'LOGNAME': 'cltbld', 05:35:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:35:52 INFO - 'MOZ_NO_REMOTE': '1', 05:35:52 INFO - 'NO_EM_RESTART': '1', 05:35:52 INFO - 'PAGER': '/bin/cat', 05:35:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:35:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:35:52 INFO - 'PWD': '/builds/slave/test', 05:35:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:35:52 INFO - 'SHELL': '/bin/bash', 05:35:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QabMDETVzg/Listeners', 05:35:52 INFO - 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/', 05:35:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:35:52 INFO - 'USER': 'cltbld', 05:35:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:35:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:35:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:35:52 INFO - 'XPC_FLAGS': '0x0', 05:35:52 INFO - 'XPC_SERVICE_NAME': '0', 05:35:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:35:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:35:52 INFO - Downloading/unpacking psutil>=0.7.1 05:35:52 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 05:35:52 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 05:35:52 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 05:35:52 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 05:35:52 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 05:35:52 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 05:35:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:35:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:35:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:35:55 INFO - Installing collected packages: psutil 05:35:55 INFO - Running setup.py install for psutil 05:35:55 INFO - building 'psutil._psutil_osx' extension 05:35:55 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 05:35:56 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 05:35:56 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 05:35:56 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 05:35:56 INFO - building 'psutil._psutil_posix' extension 05:35:56 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 05:35:56 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:35:56 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:35:56 INFO - ^ 05:35:56 INFO - 1 warning generated. 05:35:56 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 05:35:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:35:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:35:56 INFO - Successfully installed psutil 05:35:56 INFO - Cleaning up... 05:35:56 INFO - Return code: 0 05:35:56 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:35:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:35:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:35:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:35:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:35:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10cb65a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cb6c4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd32b48c9f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca09d30>, '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 0x10c86ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ca00b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kS6Wx5JK3f/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QabMDETVzg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:35:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 05:35:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:35:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kS6Wx5JK3f/Render', 05:35:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:35:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:35:56 INFO - 'HOME': '/Users/cltbld', 05:35:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:35:56 INFO - 'LOGNAME': 'cltbld', 05:35:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:35:56 INFO - 'MOZ_NO_REMOTE': '1', 05:35:56 INFO - 'NO_EM_RESTART': '1', 05:35:56 INFO - 'PAGER': '/bin/cat', 05:35:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:35:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:35:56 INFO - 'PWD': '/builds/slave/test', 05:35:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:35:56 INFO - 'SHELL': '/bin/bash', 05:35:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QabMDETVzg/Listeners', 05:35:56 INFO - 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/', 05:35:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:35:56 INFO - 'USER': 'cltbld', 05:35:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:35:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:35:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:35:56 INFO - 'XPC_FLAGS': '0x0', 05:35:56 INFO - 'XPC_SERVICE_NAME': '0', 05:35:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:35:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:35:56 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:35:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:35:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:35:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:35:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:35:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:35:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:35:59 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:35:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:35:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:35:59 INFO - Installing collected packages: mozsystemmonitor 05:35:59 INFO - Running setup.py install for mozsystemmonitor 05:35:59 INFO - Successfully installed mozsystemmonitor 05:35:59 INFO - Cleaning up... 05:35:59 INFO - Return code: 0 05:35:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:35: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')]} 05:35:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:35:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35: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')]} 05:35:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:35:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10cb65a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cb6c4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd32b48c9f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca09d30>, '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 0x10c86ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ca00b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kS6Wx5JK3f/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QabMDETVzg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:35:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:35:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:35:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kS6Wx5JK3f/Render', 05:35:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:35:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:35:59 INFO - 'HOME': '/Users/cltbld', 05:35:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:35:59 INFO - 'LOGNAME': 'cltbld', 05:35:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:35:59 INFO - 'MOZ_NO_REMOTE': '1', 05:35:59 INFO - 'NO_EM_RESTART': '1', 05:35:59 INFO - 'PAGER': '/bin/cat', 05:35:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:35:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:35:59 INFO - 'PWD': '/builds/slave/test', 05:35:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:35:59 INFO - 'SHELL': '/bin/bash', 05:35:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QabMDETVzg/Listeners', 05:35:59 INFO - 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/', 05:35:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:35:59 INFO - 'USER': 'cltbld', 05:35:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:35:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:35:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:35:59 INFO - 'XPC_FLAGS': '0x0', 05:35:59 INFO - 'XPC_SERVICE_NAME': '0', 05:35:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:35:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:35:59 INFO - Downloading/unpacking blobuploader==1.2.4 05:35:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:35:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:35:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:35:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:35:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:35:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:02 INFO - Downloading blobuploader-1.2.4.tar.gz 05:36:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:36:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:36:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:36:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:36:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:36:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:36:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:36:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:36:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:03 INFO - Downloading docopt-0.6.1.tar.gz 05:36:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:36:03 INFO - Installing collected packages: blobuploader, requests, docopt 05:36:03 INFO - Running setup.py install for blobuploader 05:36:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:36:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:36:03 INFO - Running setup.py install for requests 05:36:04 INFO - Running setup.py install for docopt 05:36:04 INFO - Successfully installed blobuploader requests docopt 05:36:04 INFO - Cleaning up... 05:36:04 INFO - Return code: 0 05:36:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:36:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:36:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:36:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10cb65a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cb6c4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd32b48c9f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca09d30>, '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 0x10c86ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ca00b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kS6Wx5JK3f/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QabMDETVzg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:36:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:36:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:36:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kS6Wx5JK3f/Render', 05:36:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:36:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:36:04 INFO - 'HOME': '/Users/cltbld', 05:36:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:36:04 INFO - 'LOGNAME': 'cltbld', 05:36:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:04 INFO - 'MOZ_NO_REMOTE': '1', 05:36:04 INFO - 'NO_EM_RESTART': '1', 05:36:04 INFO - 'PAGER': '/bin/cat', 05:36:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:36:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:36:04 INFO - 'PWD': '/builds/slave/test', 05:36:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:36:04 INFO - 'SHELL': '/bin/bash', 05:36:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QabMDETVzg/Listeners', 05:36:04 INFO - 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/', 05:36:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:36:04 INFO - 'USER': 'cltbld', 05:36:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:36:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:36:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:04 INFO - 'XPC_FLAGS': '0x0', 05:36:04 INFO - 'XPC_SERVICE_NAME': '0', 05:36:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:36:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:36:04 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-YiQncG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:36:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:36:04 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-peceVQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:36:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:36:04 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-xYzAHM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:36:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:36:04 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-nRLXQw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:36:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:36:05 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-ZKEXRs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:36:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:36:05 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-6UwlRz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:36:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:36:05 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-13LsAQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:36:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:36:05 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-dyS0Od-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:36:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:36:05 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-wZCHqK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:36:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:36:05 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-u74yHY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:36:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:36:05 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-KPxE0I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:36:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:36:05 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-jFJGLf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:36:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:36:05 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-7BOPmW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:36:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:36:06 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-75PwSf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:36:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:36:06 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-VwokQu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:36:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:36:06 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-hX9Nea-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:36:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:36:06 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-WE3tIn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:36:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:36:06 INFO - Running setup.py install for manifestparser 05:36:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:36:06 INFO - Running setup.py install for mozcrash 05:36:06 INFO - Running setup.py install for mozdebug 05:36:06 INFO - Running setup.py install for mozdevice 05:36:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:36:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:36:07 INFO - Running setup.py install for mozfile 05:36:07 INFO - Running setup.py install for mozhttpd 05:36:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:36:07 INFO - Running setup.py install for mozinfo 05:36:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:36:07 INFO - Running setup.py install for mozInstall 05:36:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:36:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:36:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:36:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:36:07 INFO - Running setup.py install for mozleak 05:36:07 INFO - Running setup.py install for mozlog 05:36:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:36:07 INFO - Running setup.py install for moznetwork 05:36:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:36:08 INFO - Running setup.py install for mozprocess 05:36:08 INFO - Running setup.py install for mozprofile 05:36:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:36:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:36:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:36:08 INFO - Running setup.py install for mozrunner 05:36:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:36:08 INFO - Running setup.py install for mozscreenshot 05:36:08 INFO - Running setup.py install for moztest 05:36:08 INFO - Running setup.py install for mozversion 05:36:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:36:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:36:09 INFO - Cleaning up... 05:36:09 INFO - Return code: 0 05:36:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:36:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:36:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:36:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:09 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 0x10cb65a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cb6c4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd32b48c9f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca09d30>, '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 0x10c86ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ca00b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kS6Wx5JK3f/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QabMDETVzg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:36:09 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 05:36:09 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 05:36:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kS6Wx5JK3f/Render', 05:36:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:36:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:36:09 INFO - 'HOME': '/Users/cltbld', 05:36:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:36:09 INFO - 'LOGNAME': 'cltbld', 05:36:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:09 INFO - 'MOZ_NO_REMOTE': '1', 05:36:09 INFO - 'NO_EM_RESTART': '1', 05:36:09 INFO - 'PAGER': '/bin/cat', 05:36:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:36:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:36:09 INFO - 'PWD': '/builds/slave/test', 05:36:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:36:09 INFO - 'SHELL': '/bin/bash', 05:36:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QabMDETVzg/Listeners', 05:36:09 INFO - 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/', 05:36:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:36:09 INFO - 'USER': 'cltbld', 05:36:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:36:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:36:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:09 INFO - 'XPC_FLAGS': '0x0', 05:36:09 INFO - 'XPC_SERVICE_NAME': '0', 05:36:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:36:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:36:09 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-x3gQB3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:36:09 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)) 05:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:36:09 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-iRKCoG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:36:09 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)) 05:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:36:09 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-bgtdJO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:36:09 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)) 05:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:36:09 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-_bXIWo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:36:09 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)) 05:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:36:09 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-tuMiQd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:36:09 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)) 05:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:36:09 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-BqYQfj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:36:09 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)) 05:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:36:09 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-fAlHVx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:36:10 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)) 05:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:36:10 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-1vibDq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:36:10 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)) 05:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:36:10 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-pLPipz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:36:10 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)) 05:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:36:10 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-OfTIAg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:36:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 05:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:36:10 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-vKEEo_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:36:10 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)) 05:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:36:10 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-9DqSc3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:36:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 05:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:36:10 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-Og8OhL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:36:10 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)) 05:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:36:10 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-vCgCXZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:36:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 05:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:36:10 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-DVvMqF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:36:10 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)) 05:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:36:10 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-eGkqQ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:36:11 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)) 05:36:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:36:11 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-Ki_JT9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:36:11 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)) 05:36:11 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)) 05:36:11 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)) 05:36:11 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)) 05:36:11 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)) 05:36:11 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)) 05:36:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:36:11 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 05:36:11 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 05:36:11 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 05:36:11 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 05:36:11 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 05:36:11 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 05:36:13 INFO - Downloading blessings-1.6.tar.gz 05:36:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:36:13 INFO - Installing collected packages: blessings 05:36:13 INFO - Running setup.py install for blessings 05:36:13 INFO - Successfully installed blessings 05:36:13 INFO - Cleaning up... 05:36:13 INFO - Return code: 0 05:36:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:36:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:36:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:36:14 INFO - Reading from file tmpfile_stdout 05:36:14 INFO - Current package versions: 05:36:14 INFO - blessings == 1.6 05:36:14 INFO - blobuploader == 1.2.4 05:36:14 INFO - docopt == 0.6.1 05:36:14 INFO - manifestparser == 1.1 05:36:14 INFO - mozInstall == 1.12 05:36:14 INFO - mozcrash == 0.17 05:36:14 INFO - mozdebug == 0.1 05:36:14 INFO - mozdevice == 0.48 05:36:14 INFO - mozfile == 1.2 05:36:14 INFO - mozhttpd == 0.7 05:36:14 INFO - mozinfo == 0.9 05:36:14 INFO - mozleak == 0.1 05:36:14 INFO - mozlog == 3.1 05:36:14 INFO - moznetwork == 0.27 05:36:14 INFO - mozprocess == 0.22 05:36:14 INFO - mozprofile == 0.28 05:36:14 INFO - mozrunner == 6.11 05:36:14 INFO - mozscreenshot == 0.1 05:36:14 INFO - mozsystemmonitor == 0.0 05:36:14 INFO - moztest == 0.7 05:36:14 INFO - mozversion == 1.4 05:36:14 INFO - psutil == 3.1.1 05:36:14 INFO - requests == 1.2.3 05:36:14 INFO - wsgiref == 0.1.2 05:36:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:36:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:36:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:36:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:14 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 0x10cb65a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cb6c4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd32b48c9f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca09d30>, '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 0x10c86ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ca00b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kS6Wx5JK3f/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QabMDETVzg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:36:14 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 05:36:14 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 05:36:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kS6Wx5JK3f/Render', 05:36:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:36:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:36:14 INFO - 'HOME': '/Users/cltbld', 05:36:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:36:14 INFO - 'LOGNAME': 'cltbld', 05:36:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:14 INFO - 'MOZ_NO_REMOTE': '1', 05:36:14 INFO - 'NO_EM_RESTART': '1', 05:36:14 INFO - 'PAGER': '/bin/cat', 05:36:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:36:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:36:14 INFO - 'PWD': '/builds/slave/test', 05:36:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:36:14 INFO - 'SHELL': '/bin/bash', 05:36:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QabMDETVzg/Listeners', 05:36:14 INFO - 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/', 05:36:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:36:14 INFO - 'USER': 'cltbld', 05:36:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:36:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:36:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:14 INFO - 'XPC_FLAGS': '0x0', 05:36:14 INFO - 'XPC_SERVICE_NAME': '0', 05:36:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:36:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:14 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)) 05:36:14 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)) 05:36:14 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)) 05:36:14 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)) 05:36:14 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)) 05:36:14 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)) 05:36:14 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)) 05:36:14 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)) 05:36:14 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)) 05:36:14 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)) 05:36:14 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)) 05:36:14 INFO - Cleaning up... 05:36:14 INFO - Return code: 0 05:36:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:36:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:36:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:36:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:14 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 0x10cb65a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cb6c4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd32b48c9f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca09d30>, '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 0x10c86ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ca00b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kS6Wx5JK3f/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QabMDETVzg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:36:14 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 05:36:14 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 05:36:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kS6Wx5JK3f/Render', 05:36:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:36:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:36:14 INFO - 'HOME': '/Users/cltbld', 05:36:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:36:14 INFO - 'LOGNAME': 'cltbld', 05:36:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:14 INFO - 'MOZ_NO_REMOTE': '1', 05:36:14 INFO - 'NO_EM_RESTART': '1', 05:36:14 INFO - 'PAGER': '/bin/cat', 05:36:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:36:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:36:14 INFO - 'PWD': '/builds/slave/test', 05:36:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:36:14 INFO - 'SHELL': '/bin/bash', 05:36:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QabMDETVzg/Listeners', 05:36:14 INFO - 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/', 05:36:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:36:14 INFO - 'USER': 'cltbld', 05:36:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:36:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:36:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:14 INFO - 'XPC_FLAGS': '0x0', 05:36:14 INFO - 'XPC_SERVICE_NAME': '0', 05:36:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:36:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:14 INFO - Downloading/unpacking jsonschema 05:36:14 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 05:36:14 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 05:36:14 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 05:36:14 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 05:36:14 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 05:36:14 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 05:36:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:36:17 INFO - Downloading/unpacking functools32 (from jsonschema) 05:36:17 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 05:36:17 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 05:36:17 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 05:36:17 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 05:36:17 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 05:36:17 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 05:36:17 INFO - Downloading functools32-3.2.3-2.tar.gz 05:36:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:36:17 INFO - warning: no files found matching '*.txt' 05:36:17 INFO - no previously-included directories found matching 'build' 05:36:17 INFO - no previously-included directories found matching 'dist' 05:36:17 INFO - no previously-included directories found matching '.git*' 05:36:17 INFO - Installing collected packages: jsonschema, functools32 05:36:17 INFO - Running setup.py install for functools32 05:36:17 INFO - warning: no files found matching '*.txt' 05:36:17 INFO - no previously-included directories found matching 'build' 05:36:17 INFO - no previously-included directories found matching 'dist' 05:36:17 INFO - no previously-included directories found matching '.git*' 05:36:17 INFO - Successfully installed jsonschema functools32 05:36:17 INFO - Cleaning up... 05:36:17 INFO - Return code: 0 05:36:17 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:36:17 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')]} 05:36:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:17 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')]} 05:36:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:17 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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10cb65a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cb6c4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd32b48c9f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca09d30>, '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 0x10c86ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ca00b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kS6Wx5JK3f/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QabMDETVzg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:36:17 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', 'flake8'] in /builds/slave/test/build 05:36:17 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 flake8 05:36:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kS6Wx5JK3f/Render', 05:36:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:36:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:36:17 INFO - 'HOME': '/Users/cltbld', 05:36:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:36:17 INFO - 'LOGNAME': 'cltbld', 05:36:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:17 INFO - 'MOZ_NO_REMOTE': '1', 05:36:17 INFO - 'NO_EM_RESTART': '1', 05:36:17 INFO - 'PAGER': '/bin/cat', 05:36:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:36:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:36:17 INFO - 'PWD': '/builds/slave/test', 05:36:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:36:17 INFO - 'SHELL': '/bin/bash', 05:36:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QabMDETVzg/Listeners', 05:36:17 INFO - 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/', 05:36:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:36:17 INFO - 'USER': 'cltbld', 05:36:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:36:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:36:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:17 INFO - 'XPC_FLAGS': '0x0', 05:36:17 INFO - 'XPC_SERVICE_NAME': '0', 05:36:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:36:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:18 INFO - Downloading/unpacking flake8 05:36:18 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 05:36:18 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 05:36:18 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 05:36:18 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 05:36:18 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 05:36:18 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 05:36:20 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:36:20 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:36:20 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 05:36:20 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 05:36:20 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 05:36:20 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 05:36:20 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 05:36:20 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 05:36:20 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:36:20 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:36:20 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 05:36:20 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 05:36:20 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 05:36:20 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 05:36:20 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 05:36:20 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 05:36:21 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:36:21 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 05:36:21 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 05:36:21 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 05:36:21 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 05:36:21 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 05:36:21 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 05:36:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:36:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:36:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:36:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:36:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:36:21 INFO - no previously-included directories found matching 'docs/_build' 05:36:21 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:36:21 INFO - Running setup.py install for pep8 05:36:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:36:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:36:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:36:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:36:21 INFO - no previously-included directories found matching 'docs/_build' 05:36:21 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:36:21 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:36:21 INFO - Cleaning up... 05:36:22 INFO - Return code: 0 05:36:22 INFO - Running post-action listener: _resource_record_post_action 05:36:22 INFO - Running post-action listener: _start_resource_monitoring 05:36:22 INFO - Starting resource monitoring. 05:36:22 INFO - ##### 05:36:22 INFO - ##### Running install step. 05:36:22 INFO - ##### 05:36:22 INFO - Running pre-action listener: _resource_record_pre_action 05:36:22 INFO - Running main action method: install 05:36:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:36:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:36:22 INFO - Reading from file tmpfile_stdout 05:36:22 INFO - Detecting whether we're running mozinstall >=1.0... 05:36:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:36:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:36:22 INFO - Reading from file tmpfile_stdout 05:36:22 INFO - Output received: 05:36:22 INFO - Usage: mozinstall [options] installer 05:36:22 INFO - Options: 05:36:22 INFO - -h, --help show this help message and exit 05:36:22 INFO - -d DEST, --destination=DEST 05:36:22 INFO - Directory to install application into. [default: 05:36:22 INFO - "/builds/slave/test"] 05:36:22 INFO - --app=APP Application being installed. [default: firefox] 05:36:22 INFO - mkdir: /builds/slave/test/build/application 05:36:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:36:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0.en-US.mac.dmg --destination /builds/slave/test/build/application 05:36:44 INFO - Reading from file tmpfile_stdout 05:36:44 INFO - Output received: 05:36:44 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 05:36:44 INFO - Running post-action listener: _resource_record_post_action 05:36:44 INFO - ##### 05:36:44 INFO - ##### Running run-tests step. 05:36:44 INFO - ##### 05:36:44 INFO - Running pre-action listener: _resource_record_pre_action 05:36:44 INFO - Running main action method: run_tests 05:36:44 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:36:44 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:36:44 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:36:44 INFO - 2016-05-09 05:36:44.831 screenresolution[1644:7643] starting screenresolution argv=screenresolution get 05:36:44 INFO - 2016-05-09 05:36:44.834 screenresolution[1644:7643] Display 0: 1600x1200x32@60 05:36:44 INFO - 2016-05-09 05:36:44.840 screenresolution[1645:7646] starting screenresolution argv=screenresolution list 05:36:44 INFO - Available Modes on Display 0 05:36:44 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:36:44 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:36:44 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:36:44 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:36:45 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:36:45 INFO - Intel Iris: 05:36:45 INFO - Chipset Model: Intel Iris 05:36:45 INFO - Type: GPU 05:36:45 INFO - Bus: Built-In 05:36:45 INFO - VRAM (Dynamic, Max): 1536 MB 05:36:45 INFO - Vendor: Intel (0x8086) 05:36:45 INFO - Device ID: 0x0a2e 05:36:45 INFO - Revision ID: 0x0009 05:36:45 INFO - Displays: 05:36:45 INFO - Display: 05:36:45 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:36:45 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:36:45 INFO - Display Serial Number: 1600x1200 60 05:36:45 INFO - Main Display: Yes 05:36:45 INFO - Mirror: Off 05:36:45 INFO - Online: Yes 05:36:45 INFO - Rotation: Supported 05:36:45 INFO - Return code: 0 05:36:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:36:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:36:45 INFO - Python 2.7.3 05:36:45 INFO - Return code: 0 05:36:45 INFO - grabbing minidump binary from tooltool 05:36: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')]} 05:36:45 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/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca09d30>, '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 0x10c86ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ca00b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:36:45 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/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:36:45 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/macosx64/releng.manifest -o -c /builds/tooltool_cache 05:36:45 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:36:45 INFO - Return code: 0 05:36:45 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:36:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:36:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:36:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:36:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:36:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:36:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:36:46 INFO - Return code: 0 05:36:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/D_vUHmeKR_2mA7juCS2aMw/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0120', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 05:36:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/D_vUHmeKR_2mA7juCS2aMw/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0120 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:36:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kS6Wx5JK3f/Render', 05:36:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:36:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:36:46 INFO - 'HOME': '/Users/cltbld', 05:36:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:36:46 INFO - 'LOGNAME': 'cltbld', 05:36:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:36:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:36:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:46 INFO - 'MOZ_NO_REMOTE': '1', 05:36:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:36:46 INFO - 'NO_EM_RESTART': '1', 05:36:46 INFO - 'PAGER': '/bin/cat', 05:36:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:36:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:36:46 INFO - 'PWD': '/builds/slave/test', 05:36:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:36:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:36:46 INFO - 'SHELL': '/bin/bash', 05:36:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QabMDETVzg/Listeners', 05:36:46 INFO - 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/', 05:36:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:36:46 INFO - 'USER': 'cltbld', 05:36:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:36:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:36:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:46 INFO - 'XPC_FLAGS': '0x0', 05:36:46 INFO - 'XPC_SERVICE_NAME': '0', 05:36:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:36:46 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/D_vUHmeKR_2mA7juCS2aMw/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0120', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:36:46 INFO - mozversion application_buildid: 20160509005545 05:36:46 INFO - mozversion application_changeset: fc51f034e4aca08b76934a832d7dc7db1954b9d2 05:36:46 INFO - mozversion application_display_name: Firefox 05:36:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:36:46 INFO - mozversion application_name: Firefox 05:36:46 INFO - mozversion application_remotingname: firefox 05:36:46 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 05:36:46 INFO - mozversion application_vendor: Mozilla 05:36:46 INFO - mozversion application_version: 47.0 05:36:46 INFO - mozversion platform_buildid: 20160509005545 05:36:46 INFO - mozversion platform_changeset: fc51f034e4aca08b76934a832d7dc7db1954b9d2 05:36:46 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 05:36:46 INFO - mozversion platform_version: 47.0 05:36:46 INFO - using testdate: 1462797406 05:36:46 INFO - actual date: 1462797406 05:36:46 INFO - starting webserver on 'localhost:49275' 05:36:46 INFO - SUITE-START | Running 2 tests 05:36:46 INFO - TEST-START | dromaeo_css 05:36:46 INFO - operating with platform_type : mac_ 05:36:46 INFO - Initialising browser for dromaeo_css test... 05:36:46 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/tmp05pAzj/profile http://localhost:49275/getInfo.html) 05:36:49 INFO - PROCESS | 1663 | __metrics Screen width/height:1600/1200 05:36:49 INFO - PROCESS | 1663 | colorDepth:24 05:36:49 INFO - PROCESS | 1663 | Browser inner width/height: 1024/689 05:36:49 INFO - PROCESS | 1663 | __metrics 05:36:49 ERROR - PROCESS | 1663 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 05:36:50 INFO - TEST-INFO | 1663: exit 0 05:36:50 INFO - Browser initialized. 05:36:50 INFO - Running cycle 1/1 for dromaeo_css test... 05:36:50 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/tmp05pAzj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:37:02 INFO - PROCESS | 1667 | RSS: Main: 168259584 05:37:02 INFO - PROCESS | 1667 | 05:37:51 INFO - PROCESS | 1667 | 1462797471711 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] 05:40:01 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49275/tests/dromaeo/cssquery-ext.html) 05:40:03 INFO - PROCESS | 1667 | RSS: Main: 182132736 05:40:03 INFO - PROCESS | 1667 | 05:43:05 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-ext.html (next: http://localhost:49275/tests/dromaeo/cssquery-jquery.html) 05:43:05 INFO - PROCESS | 1667 | RSS: Main: 193118208 05:43:05 INFO - PROCESS | 1667 | 05:46:07 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49275/tests/dromaeo/cssquery-mootools.html) 05:46:08 INFO - PROCESS | 1667 | RSS: Main: 195084288 05:46:08 INFO - PROCESS | 1667 | 05:49:09 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49275/tests/dromaeo/cssquery-prototype.html) 05:49:10 INFO - PROCESS | 1667 | RSS: Main: 198221824 05:49:10 INFO - PROCESS | 1667 | 05:52:12 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49275/tests/dromaeo/cssquery-yui.html) 05:52:13 INFO - PROCESS | 1667 | RSS: Main: 197570560 05:52:13 INFO - PROCESS | 1667 | 05:55:15 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-yui.html (next: http://localhost:49275/tests/dromaeo/cssquery-dojo.html) 05:55:15 INFO - PROCESS | 1667 | RSS: Main: 203354112 05:55:15 INFO - PROCESS | 1667 | 05:55:15 INFO - PROCESS | 1667 | __start_tp_report 05:55:15 INFO - PROCESS | 1667 | _x_x_mozilla_page_load 05:55:15 INFO - PROCESS | 1667 | _x_x_mozilla_page_load_details 05:55:15 INFO - PROCESS | 1667 | |i|pagename|runs| 05:55:15 INFO - PROCESS | 1667 | |0;dojo.html;3521.876734314299;3706.0734816295944;3726.217494326191;3745.0450135215515;3754.3617585010547;6029.487493563047;6042.697865106749;6042.818715438533;6051.667158306292;6060.424259695327;5862.853428664285;5931.199288096106;6039.245094363205;6074.726637301321;6115.357887421812;5381.973090134554;5402.135658294674;5437.483439073281;5491.752871120789;5539.058360078796;4788.611302722206;5122.462141475147;5340.198970154488;5428.67427954322;5469.781208751665;5449.3188351456065;5485.561155107582;5508.03609368361;5510.283663123788;5515.172724091378;4781.976090119562;5388.137897936312;5485.780568777264;5512.200730893998;5517.944820551783;5342.118550439173;5371.75827087782;5379.327584051994;5387;5408.45915408456;5851.800380921901;5899.32157801854;5908.97045514774;5916;5967.075103358986;6188.783392581238;6216.036514340284;6245.56281060326;6275.793581484016;6300.621962682254;6381.840453988641;6392.360763923617;6393.648349340784;6410.519211059142;6424.196975378078;6127.969360153215;6153.169322141498;6154.907676384858;6166.599171053867;6189.535784816157;6273.247210334789;6302.810915672537;6341.55609107358;6415.647139407284;6417.812704649655;6262.874742505124;6266.749330026839;6275.341089185661;6285.151504546919;6289.77985770505;6268.373162683695;6325.272593651789;6390.584612000205;6397.936020639827;6422.550421470546;6234.625922444668;6236.34518375564;6251.593646412968;6284.937150628527;6288.622682639057;6238.594491358138;6256.124142620037;6265.060240963892;6265.279492858289;6277.7175027123885;5055.69665820052;5065.21489169172;5102.234664800236;5106.591472682177;5108.719020453911;4495.887602809956;4595.954040459619;4597.678162528658;4671.0891376182;4676.228422310349;6103.328633850273;6110.114033465123;6171.84570385735;6172.660503672251;6200.503959683215;6338.746450141943;6369.14016607752;6400.39196276353;6403;6406.743730250738;5172.836111874798;5461.754221060062;5613.158026296088;6141.938580614226;6170.074488826712;5488.7530061147345;5596.496315331639;5605.915911261334;5620.1288800236025;5622.91565626516;6384.776532821329;6447.516436267205;6511.218653761579;6535.934640653532;6556.377144171296;5404.918926216189;6386.169797926425;6395.968020159869;6415.903761443676;6443.355664433519;5858.970705146618;6478.967605162133;6576.506761992774;6580.5064620152725;6596;5223.712695801767;5263.894582137641;6109.511239100772;6237.625742455467;6324.30432652417;6301.779437719658;6333.081703152925;6375.043743438336;6375.808725738235;6386.457151142205;6237.7193026314835;6256.749730010749;6259.718312676032;6262.5929314594405;6273.059041143682;4956.405231372259;5075.416327122428;6081.969590152021;6135.6932153393045;6161.537884658758;5030.597552195889;6195.938040619716;6202.658853763086;6218.751249949952;6238.407351301619;5175.197844334134;6104.236970378703;6255.78104766331;6282.1519094921605;6302.401271879165;6049.969750151221;6117.3402608778015;6121.300552271563;6132.264128304632;6167.259928808392 05:55:15 INFO - PROCESS | 1667 | |1;ext.html;531.455258360181;600.9759609615616;630.4483576870239;682.7917485167025;687.7145984416466;38983.80508097459;39290.82127536171;39708.801455992754;39725.60274397255;39834.800825995866;41354.345826166915;41951;41988.95027624311;42012.57987420125;42167.78916105415;8001.519908805476;9669.17811985982;9797.26520510961;9806.313558050939;9849.704508864745;9593.184579310768;9790.853137202948;9861.211103111735;9878.308518403715;9914.256430767686;9833.508324583778;9859.901400986006;9925.2059835213;9941.155001824853;9962.651307204249;9816.754581135458;9829.70510884671;9830.508474576278;9850.901490985141;9930.900690993107;9789;9900.356476829054;9903.306768526207;9912.157466615346;9928.652497162637;35318.823405883064;41664.583354166374;41864.581354186375;41884.37173442401;41938.58061419377;3184.092533627928;3419.145213696576;3430.5368775215525;3475.33968545978;3607.7835329880027;27871.581926271123;28131.437371252665;29042.12873613795;29267.268318292;29503.40993180146;2708.8645567721733;2809.8735556899987;2821.7319354661277;2889.2199106241405;2981.7167369100116;329609;330663;331795;332483;332776;49028;49433;49442;69297;70875;47199.292010619865;47253.76373118113;47502;48156;48227.276590851165;17102.05938673385;17105.657886842193;17480.038597876985;17612.823871761117;17888;13824.377902994389;14001;14040.859591403956;14125.434982600786;14147.787783183261;15615.843841561438;15705.450309239122;15846.366145354057;15851.207439627973;15937.760933586005;6492.902606460907;6605.603663780189;6626.966865165739;6648.800535983928;6698.363655452724;923.9399439036441;953.1659797677032;1057.624543287122;1083.913286937043;1106.2919731371928;27344.863275683496;31190.220244493616;31406.214844629067;31423.37153256922;32096.03711888647;1208.6192849252457;1221.3404761428906;1261.6719652890315;1262.6085913366885;1313.678148853518;15598.142102184262;16031.038137711774;16047.839521604634;16195;16253.106079165524;501199;525505;529952;534501;535213;51620.74189629103;62535.37464625295;63465.68267158727;64429.67785161138;64447;1494.4395851555666;1526.7328217561883;1528.2435194578754;1541.6993686231078;1544.938202471911;26393.472130557664;30529;30768.230794230323;31242.531362029134;32198.83900580482;54423.72788136034;54997.45002549923;55070.89858202894;55089.72455137699;55749.44250557443;411013;418290;422086;497151;499047;35256.471152932216;35947.10132246715;36131.81934090313;36216.637833621324;36806.44790328094;47415;48126.518734812205;48154.759226205046;48374;48995;39086.6091339083;40115.59884401118;41183;41335.586644134375;42684;39434.80282598569;39683.80158099191;39891;40471;41002.58997409988;40451.59548404478;40703;41305.793471032455;42191;42207.577924220364;30917.8454107737;33476.163095921824;33856.94235639036;34478.48282275718;34648.48027279542;25776;26754;26757.86621066882;26758.732412675625;26912 05:55:15 INFO - PROCESS | 1667 | |2;jquery.html;380.0745185473371;382.6364953294369;387.86424751337034;391.6553432978978;394.19977445785065;19771.209151633917;20355.389338319837;22321.33036008918;22412.55174896503;22689.886550567244;19937;21414.571708565818;21832.89083554584;22210.1115955362;22649.773502264972;5876.70616469177;5894;6054.394560543932;6104.938950610482;6147.7233524491285;5956.076808094731;5967.641941483504;6031.638101713889;6032.27612686476;6052.364501727321;5736.082226843706;5851.824445266649;5899.87902298564;5989.490893274077;6038.124471951564;4930.654854160211;5826.038703613898;5831.416858314155;5847.26909136358;5953;5161.61287903405;5190.584753219733;5214.8696282592855;5239.659422137549;5265.815696450644;18954.24183032677;26279.73720262792;26548.93804247828;26814.5977810333;26864.59703104455;2096.6854971754206;2145.6459684152096;2222.9555408891893;2427.514497100587;2456.803455723538;15308.387664493406;15529.301181446863;15561.455349062728;15585;15874;1487.4496436318632;1828.5611453251256;1867.6544839204792;1907;1930.1121484117323;104684.42973355406;107777.46111269394;109353.89104280724;110731;111396.4430177852;10740.78518429627;11054.944725276322;11182.832257516144;11286.322820630789;11332.263402878787;11386.259893106922;13615.910727141805;13778.724425511433;13834.377453014638;13900.721985560434;8889.19997200255;8970;9062.456252624863;9162.770930726785;9217.861732074025;7592.354649854714;9333.113354231336;9439.008904065111;9521.857172142423;9527.857082143773;6298.370162983665;6463.353664633499;6468.870622587522;6469.902951455732;6684.665766711645;1788.7674602301618;1891.564940063793;1913.2920819296671;1932.391296741522;1938.331275709878;417.22812796326554;472.6974736168855;978.9070038346346;1010.7119470950744;1125.786100640892;10382.636607718845;11886.465109070112;12240.387980600934;12495.812562811565;12610.747785044248;432.6409080463208;472.6455158631027;481.3814248690416;487.77318546875165;519.3196912045157;6349.206349206349;6372.776952806722;6444.258910225384;6458.6770661466735;6525.086487891699;679111;679898;689869;696503;699001;93126;115375;121696.39151804184;129010;130504;1035.3839465518004;1062.8352605346183;1071.5285274479204;1073.4203530093819;1086.1690806532852;18011.369602063864;18453.07734613237;18490.16794244289;19134;19391.612167756848;52451.68870778261;53196;54347.18479222736;55590.88818223532;55666.443335566124;67855.98216026665;69887.65056174686;74620.25379746134;75396;77012.2298777005;8404.117567655308;8474.66101355939;8655.518128794649;8658;8732.78168045804;12920.095593308379;13752.381142848795;13798.241096739373;14115.929420352833;14153.575392738234;11827.763444731228;11904.702382440508;11974.521019159136;11991.580294689993;12008.579699710468;11496;11588.6523404298;11781;11842.703932401759;11948.223365481215;11990.460429280529;12030.518779248732;12131.75736485283;12176.695582610506;12322.815157772462;7425.851482970203;7912.28789408956;8424;8504.362172837185;8662.393632445921;9129.680461183827;11709.189635368197;12000.63998080024;12092.758144836878;12166.330851803235 05:55:15 INFO - PROCESS | 1667 | |3;mootools.html;1628.4951664983853;1639.5245378840136;1946.6204090202416;2028.5667475908913;2041.540653352995;8319.209675080858;9084.954575227122;9134.862977055349;9292.210162136218;9294.209992150667;8956.417832840862;9080.409773364727;9102.544872756369;9209.815803683923;9222.815543689123;2576.5491039068183;2577.471618318245;2580.406506503505;2609.9217023489327;2617.306413800344;2387.438951846315;2392.007316963458;2608.191460647196;2623.121254379785;2626.921192364232;2319.9560197910923;2504.2862784106533;2598.2984594159566;2604.127617248224;2611.033917450546;2593.1313010141625;2593.6757905261843;2599.2072417912527;2612.451385209099;2636.4595257972164;2493.1453485758884;2509.8619575923317;2534.1510593951048;2555.6038813983864;2563.910263140781;9242.676506322314;9293.90706092944;9326.860097098548;9335.393199442082;9342.2526197904;5722.856928576777;5724.370319264919;5782.219400380936;5900.940990590082;5972.313183983811;3696.907577310562;3785.37541305687;3835.8657446989223;3842.8078596070363;3851.5378154621344;1074.2641290715885;1091.4215465803138;1092.3009274064605;1133.846930664358;1135.914806389524;12066.879331206663;12454.626361209179;12494.625161245178;12556.121071524996;12570.811437828439;4298.957010429918;4479.574440428154;5089.592832573385;5091.745412729349;5145.665531740425;8782.824343513093;10488;10621.150307975344;10674.252802303765;10704.78590428187;4837.564619184291;5694.772209111589;5702.173184888168;5758.769649213985;5864.472197502245;4693.906121877611;5159.613029022838;5183.352080989876;5238.528532432099;5294.364676238876;4110.630043296118;4129.607687269705;4147;4183.895402614898;4191.434156388909;1349.568138195768;1371.8010888421122;1394.4143459746729;1401.1102949626857;1401.8948578856628;1389.6248013036422;1408.2677007955806;1428.357239242345;1446.5298777897226;1479.9556013319618;8595;8616.913830861611;8624.482531048157;8632.870506942401;8640.833487479236;453.64162311773987;503.62983207342575;532.2654736463733;549.0199993012453;549.6647045302362;6329.240491141;6374.872502550016;6421.903671444932;6460.870782584322;6508;11246.718832029264;11301.095912326995;11533.653990380302;11654.359010254517;11694.47374868133;10928.508217130247;11153.051990580729;11389.886101139049;11412.258203216765;11538.307701537935;8849.557522123869;8882.511461869659;8893.510856902933;8966.103389660982;8967.865482017905;7985.560794156378;8275.462094963808;8322.417430779788;8358.03882553514;8371.497710137412;9826.16477599412;9867.55595998196;10093.19254459656;10173.745656358651;10237.795244095225;7950.562719050276;8603;10105.444200568745;10285.331453455501;10334.173266138841;7748.612569371621;7760.573168475562;7833.608319584112;7849.803754906173;7896.921030789618;7202.243764404662;8445.662173513236;8623.784405389915;8624.78438039054;8697.91302086971;7711.344535714527;7732.188120247293;7898.486598371088;7945;7987.520748755093;7614.847703045797;7706.306432421109;7717.652705628372;7747.72882949094;7786.18245084258;8122.878156827534;8138.145494723206;8157.79605509867;8223.54770487629;8237.588120594066;6337.588056776295;6413.422791948747;7303.014093097577;7325.706971721072;7363.374113200223;7287.1984081752025;7418.517796343221;7442.330190282901;7516.962415187889;7556.697732090654 05:55:15 INFO - PROCESS | 1667 | |4;prototype.html;296.78483099752697;344.21347221598637;344.38871003967955;347.7270342780916;351.2430711816037;6859.416949559293;6929.3417125373135;6945.062416573761;6973.232944376121;6989.580625162487;5405.945940540603;6824.249332573413;6832.795016149524;6837.145356830396;6914.308569143083;4448.466184057917;4651.000034992476;4938.333325001115;5135.35808023997;5227.451117632641;4085.9387109193235;5077.213031980049;5112.693238405707;5115.13042782726;5128.07694614971;5024.095662780698;5063.6202284828605;5073.771680274378;5162.457941916101;5167.896642067157;5177.741112944356;5179.119549676564;5179.834537229131;5190.584753219733;5193.376794784613;4425.269830477967;4433.8226470941445;4440;4443.044745379759;4451.1765323415275;6427.967860160716;6580.605163690194;6584.9012264816065;6605.504587155934;6646;5910.083936989773;5973.372795856416;5979.521638268928;5986.670733109677;5993.6104153230335;7436.851262974765;7446.329830315243;7456.85086298271;7472.738454154079;7473.738419155304;4802.807887684488;4833.637477189225;4834.323194752737;4838.056578967103;4843.321934929113;7078;7655.808604784925;7760.107587627439;7831.647575859043;7854.3716502679645;4810.4467986181335;4883.706977581356;4891.461939186686;4906.55840974314;4907.730074845917;4936.851894443173;4972.105021096238;4986.351774269322;4992.90014199714;4993.350864387607;4834.975825120852;5959.642421454727;5996.070609055603;5997;6028.4272994065495;7451.180370159278;7460.70157193717;7469.514481558681;7480.476366654282;7481.738139165103;1427.3006226948721;1634.1992423712295;1689.8732595055174;1695.4828777223065;1697.5416637507803;1052.4369462337613;1094.4965315954591;1095.45774841454;1099.7305660113323;1101.251149218539;6944.513884028171;7045.225025247219;7075.514142030129;7102.325279098477;7114.466415018895;6252.937470625236;7669.9616501917135;7673.808154796175;7690.192529784404;7704.92295077042;5199.324087868628;7128.964355178191;7167.3549380556;7185.101862267216;7188.784336469915;4039.2527382434346;4074.409210664437;4095.52901416335;4096.180763847243;4101.91796164075;7170.6056166910275;7989.320907722792;7997.600119993977;8007.279344858991;8013.398995075276;6370.840728981812;7630.504017238862;7929.5242285463055;7944.404169687296;7978.401619878417;7946.046474423106;7958.3235424989525;8014.799630009296;8032.995875515444;8035.879461808077;7691.307782299396;7706.884396734165;7713.112992005991;7727.11138219112;7731.845363092594;7590.8102297443;7599.696012159673;7603.619819009138;7609.467337286337;7623.580703061385;7758.107817601048;7982.441229113906;8026.558539280396;8036.4776289541;8037.31682806968;4853.39332583427;4875.098106850244;4895.241237608177;4907.2393778964315;4908.042931628441;6873.5875847449315;7108.537945033556;7706.691732330644;7726.729564465217;7797;7407.703691852265;7436.107667079768;7437.070366204224;7456.813579660552;7502.249775022454;7158.713651453883;7469.402447804271;7490.101187857492;7491.513051651626;7503.362214211853;7212.819679507845;7252.601106939169;7262.600556969206;7308.524945878501;7317.926820731937;7467.850642987219;7479.139898911695;7485.251474852471;7490.812729681802;7492.550446973199;7028.508004439845;7259.6007219603425;7311.707531698672;7324.780256592311;7357 05:55:15 INFO - PROCESS | 1667 | |5;yui.html;718.5544962123481;719.1478098453333;746.0934964018716;778.3345239819951;781.6560713286152;15709.62243117731;15806.920965395186;15927.044377337368;15927.283272252747;16010.43963461279;14563.417463301455;14601;14615.707685846277;14616.4884229052;14658.706825863477;781.0861292288008;981.4503877828404;985.9556319965601;1008.2639673038686;1008.5915204342253;966.7631430299587;975.2490582251662;979.7109852593502;990.6681261777313;993.9503024848765;1015.4313584392727;1047.1779652972418;1059.2108878885242;1059.3537941855461;1060.835570486572;1034.7723500829843;1038.7299302181411;1042.9843552346722;1051.5215576912487;1056.1603525197486;741.7774667599753;742.1835980421547;746.8991686122358;752.766642340876;763.084298841387;15288.694226115414;15305.540833775005;15321.693566128726;15334.156621385819;15644.843551564452;13386.799198012037;13452.394642241123;13462.730745385037;13538.458461661521;13581.320933953262;10380.948095259475;10457.84313235302;10469.895301046969;10472.895271047268;10537.473126343652;3636.236390358028;3642.3261696586214;3645.3620616392027;3683.6684698377007;3724.6647801697977;83832;85590.57204713998;85706;85926;86531.56734216351;7460.250106082941;7484.363829074481;8959.283257339397;9089.318301127441;9165.33853662418;17055.147242637817;20426.38720838377;20585.588288234452;20596.485087872923;20776.27283045086;6559.573627714183;6647.833804154935;7716.344110750649;7741.535507869546;8007.399445041645;4293.8711838644895;4366.563343665608;4371;4426.84506042287;4430.778461076933;3717.386631205875;3724.497192878981;3747.5690295616355;3757.9436308455397;3764.4917936078277;710.3748701142961;717.2074857282731;721.5670597641373;723.7466886589651;738.6380673470069;468.3910915809434;525.2882344423327;608.57703895792;616.0881894795727;619.454879705856;7909.446338756232;8052.194780521901;8052.798680033046;8302.54336011525;8420.200080992296;572.2160639923331;607.2197226563844;620.525298146918;628.136312570216;630.7760744935573;3947.703922205846;3985.561588225351;4004.3593025115842;4031.7984100794843;4202.537720850704;89949;91582;91929.62105568421;92808;93265.5336723312;77117.22882771213;77436;78563;79039;79147.41705165865;67021.66489167523;67700;69824.3017569828;70134.59730805355;71283.28716712767;7862.960685196537;7990.720324788605;8106.8783968241705;8288.129746376784;8437.367197460339;46808.76595617;47020.529794701615;47468.52531474779;48131.75934120447;49407.75296123496;49748.253776192665;64479;66251;66663.00005499825;68041;11147.386893720599;11539.249948753304;11544.19190656646;11666.183367164556;11776.411179441166;12248.938755306166;12343.321117338273;12376.938115309365;12400.875991239973;12832.29422381778;11810.527578896748;12003.039756819258;12046.518139274682;12090.818637720266;12363;11691.123165762432;11855.644330670093;12027.699307517032;12049.554053513635;12099;11714.648560543197;11736.94131529371;11816.645500634651;11832;11981.700457488632;9542.284328675238;9868.457234851865;10064.647737329158;10103.848442273225;10282.897171028193;9826.606935722491;10185.33795303303;10206.132478739093;10257.74355641115;10261.435621040615 05:55:15 INFO - PROCESS | 1667 | __end_tp_report 05:55:15 INFO - PROCESS | 1667 | __start_cc_report 05:55:15 INFO - PROCESS | 1667 | _x_x_mozilla_cycle_collect,351 05:55:15 INFO - PROCESS | 1667 | __end_cc_report 05:55:15 INFO - PROCESS | 1667 | __startTimestamp1462798515659__endTimestamp 05:55:15 INFO - PROCESS | 1667 | 05:55:15 INFO - PROCESS | 1667 | ------- Summary: start ------- 05:55:15 INFO - PROCESS | 1667 | Number of tests: 6 05:55:15 INFO - PROCESS | 1667 | 05:55:15 INFO - PROCESS | 1667 | [#0] dojo.html Cycles:165 Average:5870.87 Median:6141.94 stddev:629.43 (10.2%) stddev-sans-first:603.79 05:55:15 INFO - PROCESS | 1667 | Values: 3521.9 3706.1 3726.2 3745.0 3754.4 6029.5 6042.7 6042.8 6051.7 6060.4 5862.9 5931.2 6039.2 6074.7 6115.4 5382.0 5402.1 5437.5 5491.8 5539.1 4788.6 5122.5 5340.2 5428.7 5469.8 5449.3 5485.6 5508.0 5510.3 5515.2 4782.0 5388.1 5485.8 5512.2 5517.9 5342.1 5371.8 5379.3 5387.0 5408.5 5851.8 5899.3 5909.0 5916.0 5967.1 6188.8 6216.0 6245.6 6275.8 6300.6 6381.8 6392.4 6393.6 6410.5 6424.2 6128.0 6153.2 6154.9 6166.6 6189.5 6273.2 6302.8 6341.6 6415.6 6417.8 6262.9 6266.7 6275.3 6285.2 6289.8 6268.4 6325.3 6390.6 6397.9 6422.6 6234.6 6236.3 6251.6 6284.9 6288.6 6238.6 6256.1 6265.1 6265.3 6277.7 5055.7 5065.2 5102.2 5106.6 5108.7 4495.9 4596.0 4597.7 4671.1 4676.2 6103.3 6110.1 6171.8 6172.7 6200.5 6338.7 6369.1 6400.4 6403.0 6406.7 5172.8 5461.8 5613.2 6141.9 6170.1 5488.8 5596.5 5605.9 5620.1 5622.9 6384.8 6447.5 6511.2 6535.9 6556.4 5404.9 6386.2 6396.0 6415.9 6443.4 5859.0 6479.0 6576.5 6580.5 6596.0 5223.7 5263.9 6109.5 6237.6 6324.3 6301.8 6333.1 6375.0 6375.8 6386.5 6237.7 6256.7 6259.7 6262.6 6273.1 4956.4 5075.4 6082.0 6135.7 6161.5 5030.6 6195.9 6202.7 6218.8 6238.4 5175.2 6104.2 6255.8 6282.2 6302.4 6050.0 6117.3 6121.3 6132.3 6167.3 05:55:15 INFO - PROCESS | 1667 | 05:55:15 INFO - PROCESS | 1667 | [#1] ext.html Cycles:180 Average:59324.89 Median:40587.00 stddev:117594.91 (289.7%) stddev-sans-first:117841.94 05:55:15 INFO - PROCESS | 1667 | Values: 531.5 601.0 630.4 682.8 687.7 38983.8 39290.8 39708.8 39725.6 39834.8 41354.3 41951.0 41989.0 42012.6 42167.8 8001.5 9669.2 9797.3 9806.3 9849.7 9593.2 9790.9 9861.2 9878.3 9914.3 9833.5 9859.9 9925.2 9941.2 9962.7 9816.8 9829.7 9830.5 9850.9 9930.9 9789.0 9900.4 9903.3 9912.2 9928.7 35318.8 41664.6 41864.6 41884.4 41938.6 3184.1 3419.1 3430.5 3475.3 3607.8 27871.6 28131.4 29042.1 29267.3 29503.4 2708.9 2809.9 2821.7 2889.2 2981.7 329609.0 330663.0 331795.0 332483.0 332776.0 49028.0 49433.0 49442.0 69297.0 70875.0 47199.3 47253.8 47502.0 48156.0 48227.3 17102.1 17105.7 17480.0 17612.8 17888.0 13824.4 14001.0 14040.9 14125.4 14147.8 15615.8 15705.5 15846.4 15851.2 15937.8 6492.9 6605.6 6627.0 6648.8 6698.4 923.9 953.2 1057.6 1083.9 1106.3 27344.9 31190.2 31406.2 31423.4 32096.0 1208.6 1221.3 1261.7 1262.6 1313.7 15598.1 16031.0 16047.8 16195.0 16253.1 501199.0 525505.0 529952.0 534501.0 535213.0 51620.7 62535.4 63465.7 64429.7 64447.0 1494.4 1526.7 1528.2 1541.7 1544.9 26393.5 30529.0 30768.2 31242.5 32198.8 54423.7 54997.5 55070.9 55089.7 55749.4 411013.0 418290.0 422086.0 497151.0 499047.0 35256.5 35947.1 36131.8 36216.6 36806.4 47415.0 48126.5 48154.8 48374.0 48995.0 39086.6 40115.6 41183.0 41335.6 42684.0 39434.8 39683.8 39891.0 40471.0 41002.6 40451.6 40703.0 41305.8 42191.0 42207.6 30917.8 33476.2 33856.9 34478.5 34648.5 25776.0 26754.0 26757.9 26758.7 26912.0 05:55:15 INFO - PROCESS | 1667 | 05:55:15 INFO - PROCESS | 1667 | [#2] jquery.html Cycles:180 Average:36887.44 Median:14368.27 stddev:113818.17 (792.1%) stddev-sans-first:114104.45 05:55:15 INFO - PROCESS | 1667 | Values: 380.1 382.6 387.9 391.7 394.2 19771.2 20355.4 22321.3 22412.6 22689.9 19937.0 21414.6 21832.9 22210.1 22649.8 5876.7 5894.0 6054.4 6104.9 6147.7 5956.1 5967.6 6031.6 6032.3 6052.4 5736.1 5851.8 5899.9 5989.5 6038.1 4930.7 5826.0 5831.4 5847.3 5953.0 5161.6 5190.6 5214.9 5239.7 5265.8 18954.2 26279.7 26548.9 26814.6 26864.6 2096.7 2145.6 2223.0 2427.5 2456.8 15308.4 15529.3 15561.5 15585.0 15874.0 1487.4 1828.6 1867.7 1907.0 1930.1 104684.4 107777.5 109353.9 110731.0 111396.4 10740.8 11054.9 11182.8 11286.3 11332.3 11386.3 13615.9 13778.7 13834.4 13900.7 8889.2 8970.0 9062.5 9162.8 9217.9 7592.4 9333.1 9439.0 9521.9 9527.9 6298.4 6463.4 6468.9 6469.9 6684.7 1788.8 1891.6 1913.3 1932.4 1938.3 417.2 472.7 978.9 1010.7 1125.8 10382.6 11886.5 12240.4 12495.8 12610.7 432.6 472.6 481.4 487.8 519.3 6349.2 6372.8 6444.3 6458.7 6525.1 679111.0 679898.0 689869.0 696503.0 699001.0 93126.0 115375.0 121696.4 129010.0 130504.0 1035.4 1062.8 1071.5 1073.4 1086.2 18011.4 18453.1 18490.2 19134.0 19391.6 52451.7 53196.0 54347.2 55590.9 55666.4 67856.0 69887.7 74620.3 75396.0 77012.2 8404.1 8474.7 8655.5 8658.0 8732.8 12920.1 13752.4 13798.2 14115.9 14153.6 11827.8 11904.7 11974.5 11991.6 12008.6 11496.0 11588.7 11781.0 11842.7 11948.2 11990.5 12030.5 12131.8 12176.7 12322.8 7425.9 7912.3 8424.0 8504.4 8662.4 9129.7 11709.2 12000.6 12092.8 12166.3 05:55:15 INFO - PROCESS | 1667 | 05:55:15 INFO - PROCESS | 1667 | [#3] mootools.html Cycles:180 Average:6312.48 Median:5210.94 stddev:3348.82 (64.3%) stddev-sans-first:3339.71 05:55:15 INFO - PROCESS | 1667 | Values: 1628.5 1639.5 1946.6 2028.6 2041.5 8319.2 9085.0 9134.9 9292.2 9294.2 8956.4 9080.4 9102.5 9209.8 9222.8 2576.5 2577.5 2580.4 2609.9 2617.3 2387.4 2392.0 2608.2 2623.1 2626.9 2320.0 2504.3 2598.3 2604.1 2611.0 2593.1 2593.7 2599.2 2612.5 2636.5 2493.1 2509.9 2534.2 2555.6 2563.9 9242.7 9293.9 9326.9 9335.4 9342.3 5722.9 5724.4 5782.2 5900.9 5972.3 3696.9 3785.4 3835.9 3842.8 3851.5 1074.3 1091.4 1092.3 1133.8 1135.9 12066.9 12454.6 12494.6 12556.1 12570.8 4299.0 4479.6 5089.6 5091.7 5145.7 8782.8 10488.0 10621.2 10674.3 10704.8 4837.6 5694.8 5702.2 5758.8 5864.5 4693.9 5159.6 5183.4 5238.5 5294.4 4110.6 4129.6 4147.0 4183.9 4191.4 1349.6 1371.8 1394.4 1401.1 1401.9 1389.6 1408.3 1428.4 1446.5 1480.0 8595.0 8616.9 8624.5 8632.9 8640.8 453.6 503.6 532.3 549.0 549.7 6329.2 6374.9 6421.9 6460.9 6508.0 11246.7 11301.1 11533.7 11654.4 11694.5 10928.5 11153.1 11389.9 11412.3 11538.3 8849.6 8882.5 8893.5 8966.1 8967.9 7985.6 8275.5 8322.4 8358.0 8371.5 9826.2 9867.6 10093.2 10173.7 10237.8 7950.6 8603.0 10105.4 10285.3 10334.2 7748.6 7760.6 7833.6 7849.8 7896.9 7202.2 8445.7 8623.8 8624.8 8697.9 7711.3 7732.2 7898.5 7945.0 7987.5 7614.8 7706.3 7717.7 7747.7 7786.2 8122.9 8138.1 8157.8 8223.5 8237.6 6337.6 6413.4 7303.0 7325.7 7363.4 7287.2 7418.5 7442.3 7517.0 7556.7 05:55:15 INFO - PROCESS | 1667 | 05:55:15 INFO - PROCESS | 1667 | [#4] prototype.html Cycles:180 Average:6050.68 Median:6936.93 stddev:1947.11 (28.1%) stddev-sans-first:1904.08 05:55:15 INFO - PROCESS | 1667 | Values: 296.8 344.2 344.4 347.7 351.2 6859.4 6929.3 6945.1 6973.2 6989.6 5405.9 6824.2 6832.8 6837.1 6914.3 4448.5 4651.0 4938.3 5135.4 5227.5 4085.9 5077.2 5112.7 5115.1 5128.1 5024.1 5063.6 5073.8 5162.5 5167.9 5177.7 5179.1 5179.8 5190.6 5193.4 4425.3 4433.8 4440.0 4443.0 4451.2 6428.0 6580.6 6584.9 6605.5 6646.0 5910.1 5973.4 5979.5 5986.7 5993.6 7436.9 7446.3 7456.9 7472.7 7473.7 4802.8 4833.6 4834.3 4838.1 4843.3 7078.0 7655.8 7760.1 7831.6 7854.4 4810.4 4883.7 4891.5 4906.6 4907.7 4936.9 4972.1 4986.4 4992.9 4993.4 4835.0 5959.6 5996.1 5997.0 6028.4 7451.2 7460.7 7469.5 7480.5 7481.7 1427.3 1634.2 1689.9 1695.5 1697.5 1052.4 1094.5 1095.5 1099.7 1101.3 6944.5 7045.2 7075.5 7102.3 7114.5 6252.9 7670.0 7673.8 7690.2 7704.9 5199.3 7129.0 7167.4 7185.1 7188.8 4039.3 4074.4 4095.5 4096.2 4101.9 7170.6 7989.3 7997.6 8007.3 8013.4 6370.8 7630.5 7929.5 7944.4 7978.4 7946.0 7958.3 8014.8 8033.0 8035.9 7691.3 7706.9 7713.1 7727.1 7731.8 7590.8 7599.7 7603.6 7609.5 7623.6 7758.1 7982.4 8026.6 8036.5 8037.3 4853.4 4875.1 4895.2 4907.2 4908.0 6873.6 7108.5 7706.7 7726.7 7797.0 7407.7 7436.1 7437.1 7456.8 7502.2 7158.7 7469.4 7490.1 7491.5 7503.4 7212.8 7252.6 7262.6 7308.5 7317.9 7467.9 7479.1 7485.3 7490.8 7492.6 7028.5 7259.6 7311.7 7324.8 7357.0 05:55:15 INFO - PROCESS | 1667 | 05:55:15 INFO - PROCESS | 1667 | [#5] yui.html Cycles:180 Average:18350.05 Median:4368.78 stddev:25617.75 (586.4%) stddev-sans-first:25655.40 05:55:15 INFO - PROCESS | 1667 | Values: 718.6 719.1 746.1 778.3 781.7 15709.6 15806.9 15927.0 15927.3 16010.4 14563.4 14601.0 14615.7 14616.5 14658.7 781.1 981.5 986.0 1008.3 1008.6 966.8 975.2 979.7 990.7 994.0 1015.4 1047.2 1059.2 1059.4 1060.8 1034.8 1038.7 1043.0 1051.5 1056.2 741.8 742.2 746.9 752.8 763.1 15288.7 15305.5 15321.7 15334.2 15644.8 13386.8 13452.4 13462.7 13538.5 13581.3 10380.9 10457.8 10469.9 10472.9 10537.5 3636.2 3642.3 3645.4 3683.7 3724.7 83832.0 85590.6 85706.0 85926.0 86531.6 7460.3 7484.4 8959.3 9089.3 9165.3 17055.1 20426.4 20585.6 20596.5 20776.3 6559.6 6647.8 7716.3 7741.5 8007.4 4293.9 4366.6 4371.0 4426.8 4430.8 3717.4 3724.5 3747.6 3757.9 3764.5 710.4 717.2 721.6 723.7 738.6 468.4 525.3 608.6 616.1 619.5 7909.4 8052.2 8052.8 8302.5 8420.2 572.2 607.2 620.5 628.1 630.8 3947.7 3985.6 4004.4 4031.8 4202.5 89949.0 91582.0 91929.6 92808.0 93265.5 77117.2 77436.0 78563.0 79039.0 79147.4 67021.7 67700.0 69824.3 70134.6 71283.3 7863.0 7990.7 8106.9 8288.1 8437.4 46808.8 47020.5 47468.5 48131.8 49407.8 49748.3 64479.0 66251.0 66663.0 68041.0 11147.4 11539.2 11544.2 11666.2 11776.4 12248.9 12343.3 12376.9 12400.9 12832.3 11810.5 12003.0 12046.5 12090.8 12363.0 11691.1 11855.6 12027.7 12049.6 12099.0 11714.6 11736.9 11816.6 11832.0 11981.7 9542.3 9868.5 10064.6 10103.8 10282.9 9826.6 10185.3 10206.1 10257.7 10261.4 05:55:15 INFO - PROCESS | 1667 | -------- Summary: end -------- 05:55:15 INFO - PROCESS | 1667 | 05:55:16 INFO - TEST-INFO | 1667: exit 0 05:55:16 INFO - TEST-OK | dromaeo_css | took 1109552ms 05:55:16 INFO - TEST-START | kraken 05:55:16 INFO - operating with platform_type : mac_ 05:55:16 INFO - Initialising browser for kraken test... 05:55:16 INFO - TEST-INFO | started process 1678 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/tmp6iF6wK/profile http://localhost:49275/getInfo.html) 05:55:18 INFO - PROCESS | 1678 | __metrics Screen width/height:1600/1200 05:55:18 INFO - PROCESS | 1678 | colorDepth:24 05:55:18 INFO - PROCESS | 1678 | Browser inner width/height: 1024/689 05:55:18 INFO - PROCESS | 1678 | __metrics 05:55:18 ERROR - PROCESS | 1678 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 05:55:19 INFO - TEST-INFO | 1678: exit 0 05:55:19 INFO - Browser initialized. 05:55:19 INFO - Running cycle 1/1 for kraken test... 05:55:19 INFO - TEST-INFO | started process 1682 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/tmp6iF6wK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:55:31 INFO - PROCESS | 1682 | RSS: Main: 168112128 05:55:31 INFO - PROCESS | 1682 | 05:55:33 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection) 05:55:34 INFO - PROCESS | 1682 | RSS: Main: 180232192 05:55:34 INFO - PROCESS | 1682 | 05:55:37 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-dft) 05:55:37 INFO - PROCESS | 1682 | RSS: Main: 188821504 05:55:37 INFO - PROCESS | 1682 | 05:55:41 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-fft) 05:55:41 INFO - PROCESS | 1682 | RSS: Main: 192839680 05:55:41 INFO - PROCESS | 1682 | 05:55:43 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator) 05:55:44 INFO - PROCESS | 1682 | RSS: Main: 193298432 05:55:44 INFO - PROCESS | 1682 | 05:55:46 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:55:46 INFO - PROCESS | 1682 | RSS: Main: 193564672 05:55:46 INFO - PROCESS | 1682 | 05:55:49 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom) 05:55:50 INFO - PROCESS | 1682 | RSS: Main: 194859008 05:55:50 INFO - PROCESS | 1682 | 05:55:53 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate) 05:55:53 INFO - PROCESS | 1682 | RSS: Main: 194703360 05:55:53 INFO - PROCESS | 1682 | 05:55:56 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial) 05:55:57 INFO - PROCESS | 1682 | RSS: Main: 194822144 05:55:57 INFO - PROCESS | 1682 | 05:55:58 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:55:59 INFO - PROCESS | 1682 | RSS: Main: 194281472 05:55:59 INFO - PROCESS | 1682 | 05:56:01 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:56:01 INFO - PROCESS | 1682 | RSS: Main: 194363392 05:56:01 INFO - PROCESS | 1682 | 05:56:03 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:56:04 INFO - PROCESS | 1682 | RSS: Main: 194584576 05:56:04 INFO - PROCESS | 1682 | 05:56:07 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:56:07 INFO - PROCESS | 1682 | RSS: Main: 194662400 05:56:07 INFO - PROCESS | 1682 | 05:56:10 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:56:10 INFO - PROCESS | 1682 | RSS: Main: 194777088 05:56:10 INFO - PROCESS | 1682 | 05:56:12 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49275/tests/kraken/driver.html?testName=ai-astar) 05:56:12 INFO - PROCESS | 1682 | RSS: Main: 196259840 05:56:12 INFO - PROCESS | 1682 | 05:56:12 INFO - PROCESS | 1682 | __start_tp_report 05:56:12 INFO - PROCESS | 1682 | _x_x_mozilla_page_load 05:56:12 INFO - PROCESS | 1682 | _x_x_mozilla_page_load_details 05:56:12 INFO - PROCESS | 1682 | |i|pagename|runs| 05:56:12 INFO - PROCESS | 1682 | |0;ai-astar;115;110;116;118;117;131;114;118;159;168 05:56:12 INFO - PROCESS | 1682 | |1;audio-beat-detection;149;122;152;144;119;154;169;125;181;147 05:56:12 INFO - PROCESS | 1682 | |2;audio-dft;271;196;184;267;202;188;174;259;187;172 05:56:12 INFO - PROCESS | 1682 | |3;audio-fft;66;75;60;112;48;68;59;52;141;83 05:56:12 INFO - PROCESS | 1682 | |4;audio-oscillator;82;82;116;81;97;72;105;75;107;152 05:56:12 INFO - PROCESS | 1682 | |5;imaging-gaussian-blur;89;86;88;86;89;85;89;85;88;108 05:56:12 INFO - PROCESS | 1682 | |6;imaging-darkroom;92;95;94;95;95;117;149;123;136;147 05:56:12 INFO - PROCESS | 1682 | |7;imaging-desaturate;91;94;128;149;98;98;92;90;90;91 05:56:12 INFO - PROCESS | 1682 | |8;json-parse-financial;54;57;59;58;57;60;61;59;59;66 05:56:12 INFO - PROCESS | 1682 | |9;json-stringify-tinderbox;64;107;70;62;88;95;64;65;65;65 05:56:12 INFO - PROCESS | 1682 | |10;stanford-crypto-aes;82;83;83;83;82;81;80;83;80;87 05:56:12 INFO - PROCESS | 1682 | |11;stanford-crypto-ccm;129;121;140;135;139;135;122;120;130;138 05:56:12 INFO - PROCESS | 1682 | |12;stanford-crypto-pbkdf2;136;135;142;151;139;140;138;134;137;125 05:56:12 INFO - PROCESS | 1682 | |13;stanford-crypto-sha256-iterative;68;66;68;66;69;67;67;68;66;65 05:56:12 INFO - PROCESS | 1682 | __end_tp_report 05:56:12 INFO - PROCESS | 1682 | __start_cc_report 05:56:12 INFO - PROCESS | 1682 | _x_x_mozilla_cycle_collect,919 05:56:12 INFO - PROCESS | 1682 | __end_cc_report 05:56:12 INFO - PROCESS | 1682 | __startTimestamp1462798572670__endTimestamp 05:56:12 INFO - PROCESS | 1682 | 05:56:12 INFO - PROCESS | 1682 | ------- Summary: start ------- 05:56:12 INFO - PROCESS | 1682 | Number of tests: 14 05:56:12 INFO - PROCESS | 1682 | 05:56:12 INFO - PROCESS | 1682 | [#0] ai-astar Cycles:10 Average:126.60 Median:118.00 stddev:20.29 (17.2%) stddev-sans-first:21.08 05:56:12 INFO - PROCESS | 1682 | Values: 115.0 110.0 116.0 118.0 117.0 131.0 114.0 118.0 159.0 168.0 05:56:12 INFO - PROCESS | 1682 | 05:56:12 INFO - PROCESS | 1682 | [#1] audio-beat-detection Cycles:10 Average:146.20 Median:150.50 stddev:20.04 (13.3%) stddev-sans-first:21.23 05:56:12 INFO - PROCESS | 1682 | Values: 149.0 122.0 152.0 144.0 119.0 154.0 169.0 125.0 181.0 147.0 05:56:12 INFO - PROCESS | 1682 | 05:56:12 INFO - PROCESS | 1682 | [#2] audio-dft Cycles:10 Average:210.00 Median:199.00 stddev:39.52 (19.9%) stddev-sans-first:35.22 05:56:12 INFO - PROCESS | 1682 | Values: 271.0 196.0 184.0 267.0 202.0 188.0 174.0 259.0 187.0 172.0 05:56:12 INFO - PROCESS | 1682 | 05:56:12 INFO - PROCESS | 1682 | [#3] audio-fft Cycles:10 Average:76.40 Median:63.00 stddev:29.13 (46.2%) stddev-sans-first:30.66 05:56:12 INFO - PROCESS | 1682 | Values: 66.0 75.0 60.0 112.0 48.0 68.0 59.0 52.0 141.0 83.0 05:56:12 INFO - PROCESS | 1682 | 05:56:12 INFO - PROCESS | 1682 | [#4] audio-oscillator Cycles:10 Average:96.90 Median:78.00 stddev:24.42 (31.3%) stddev-sans-first:25.29 05:56:12 INFO - PROCESS | 1682 | Values: 82.0 82.0 116.0 81.0 97.0 72.0 105.0 75.0 107.0 152.0 05:56:12 INFO - PROCESS | 1682 | 05:56:12 INFO - PROCESS | 1682 | [#5] imaging-gaussian-blur Cycles:10 Average:89.30 Median:88.00 stddev:6.77 (7.7%) stddev-sans-first:7.18 05:56:12 INFO - PROCESS | 1682 | Values: 89.0 86.0 88.0 86.0 89.0 85.0 89.0 85.0 88.0 108.0 05:56:12 INFO - PROCESS | 1682 | 05:56:12 INFO - PROCESS | 1682 | [#6] imaging-darkroom Cycles:10 Average:114.30 Median:93.00 stddev:23.22 (25.0%) stddev-sans-first:23.19 05:56:12 INFO - PROCESS | 1682 | Values: 92.0 95.0 94.0 95.0 95.0 117.0 149.0 123.0 136.0 147.0 05:56:12 INFO - PROCESS | 1682 | 05:56:12 INFO - PROCESS | 1682 | [#7] imaging-desaturate Cycles:10 Average:102.10 Median:91.50 stddev:20.03 (21.9%) stddev-sans-first:20.84 05:56:12 INFO - PROCESS | 1682 | Values: 91.0 94.0 128.0 149.0 98.0 98.0 92.0 90.0 90.0 91.0 05:56:12 INFO - PROCESS | 1682 | 05:56:12 INFO - PROCESS | 1682 | [#8] json-parse-financial Cycles:10 Average:59.00 Median:59.00 stddev:3.13 (5.3%) stddev-sans-first:2.74 05:56:12 INFO - PROCESS | 1682 | Values: 54.0 57.0 59.0 58.0 57.0 60.0 61.0 59.0 59.0 66.0 05:56:12 INFO - PROCESS | 1682 | 05:56:12 INFO - PROCESS | 1682 | [#9] json-stringify-tinderbox Cycles:10 Average:74.50 Median:65.00 stddev:16.08 (24.7%) stddev-sans-first:16.60 05:56:12 INFO - PROCESS | 1682 | Values: 64.0 107.0 70.0 62.0 88.0 95.0 64.0 65.0 65.0 65.0 05:56:12 INFO - PROCESS | 1682 | 05:56:12 INFO - PROCESS | 1682 | [#10] stanford-crypto-aes Cycles:10 Average:82.40 Median:83.00 stddev:2.01 (2.4%) stddev-sans-first:2.13 05:56:12 INFO - PROCESS | 1682 | Values: 82.0 83.0 83.0 83.0 82.0 81.0 80.0 83.0 80.0 87.0 05:56:12 INFO - PROCESS | 1682 | 05:56:12 INFO - PROCESS | 1682 | [#11] stanford-crypto-ccm Cycles:10 Average:130.90 Median:135.00 stddev:7.69 (5.7%) stddev-sans-first:8.13 05:56:12 INFO - PROCESS | 1682 | Values: 129.0 121.0 140.0 135.0 139.0 135.0 122.0 120.0 130.0 138.0 05:56:12 INFO - PROCESS | 1682 | 05:56:12 INFO - PROCESS | 1682 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:137.70 Median:138.50 stddev:6.57 (4.7%) stddev-sans-first:6.94 05:56:12 INFO - PROCESS | 1682 | Values: 136.0 135.0 142.0 151.0 139.0 140.0 138.0 134.0 137.0 125.0 05:56:12 INFO - PROCESS | 1682 | 05:56:12 INFO - PROCESS | 1682 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.50 stddev:1.25 (1.8%) stddev-sans-first:1.27 05:56:12 INFO - PROCESS | 1682 | Values: 68.0 66.0 68.0 66.0 69.0 67.0 67.0 68.0 66.0 65.0 05:56:12 INFO - PROCESS | 1682 | -------- Summary: end -------- 05:56:12 INFO - PROCESS | 1682 | 05:56:13 INFO - TEST-INFO | 1682: exit 0 05:56:13 INFO - TEST-OK | kraken | took 57252ms 05:56:13 INFO - SUITE-END | took 1166s 05:56:13 INFO - Completed test suite (00:19:27) 05:56:13 INFO - javascript benchmark 05:56:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3521.876734314299, 3706.0734816295944, 3726.217494326191, 3745.0450135215515, 3754.3617585010547, 6029.487493563047, 6042.697865106749, 6042.818715438533, 6051.667158306292, 6060.424259695327, 5862.853428664285, 5931.199288096106, 6039.245094363205, 6074.726637301321, 6115.357887421812, 5381.973090134554, 5402.135658294674, 5437.483439073281, 5491.752871120789, 5539.058360078796, 4788.611302722206, 5122.462141475147, 5340.198970154488, 5428.67427954322, 5469.781208751665, 5449.3188351456065, 5485.561155107582, 5508.03609368361, 5510.283663123788, 5515.172724091378, 4781.976090119562, 5388.137897936312, 5485.780568777264, 5512.200730893998, 5517.944820551783, 5342.118550439173, 5371.75827087782, 5379.327584051994, 5387.0, 5408.45915408456, 5851.800380921901, 5899.32157801854, 5908.97045514774, 5916.0, 5967.075103358986, 6188.783392581238, 6216.036514340284, 6245.56281060326, 6275.793581484016, 6300.621962682254, 6381.840453988641, 6392.360763923617, 6393.648349340784, 6410.519211059142, 6424.196975378078, 6127.969360153215, 6153.169322141498, 6154.907676384858, 6166.599171053867, 6189.535784816157, 6273.247210334789, 6302.810915672537, 6341.55609107358, 6415.647139407284, 6417.812704649655, 6262.874742505124, 6266.749330026839, 6275.341089185661, 6285.151504546919, 6289.77985770505, 6268.373162683695, 6325.272593651789, 6390.584612000205, 6397.936020639827, 6422.550421470546, 6234.625922444668, 6236.34518375564, 6251.593646412968, 6284.937150628527, 6288.622682639057, 6238.594491358138, 6256.124142620037, 6265.060240963892, 6265.279492858289, 6277.7175027123885, 5055.69665820052, 5065.21489169172, 5102.234664800236, 5106.591472682177, 5108.719020453911, 4495.887602809956, 4595.954040459619, 4597.678162528658, 4671.0891376182, 4676.228422310349, 6103.328633850273, 6110.114033465123, 6171.84570385735, 6172.660503672251, 6200.503959683215, 6338.746450141943, 6369.14016607752, 6400.39196276353, 6403.0, 6406.743730250738, 5172.836111874798, 5461.754221060062, 5613.158026296088, 6141.938580614226, 6170.074488826712, 5488.7530061147345, 5596.496315331639, 5605.915911261334, 5620.1288800236025, 5622.91565626516, 6384.776532821329, 6447.516436267205, 6511.218653761579, 6535.934640653532, 6556.377144171296, 5404.918926216189, 6386.169797926425, 6395.968020159869, 6415.903761443676, 6443.355664433519, 5858.970705146618, 6478.967605162133, 6576.506761992774, 6580.5064620152725, 6596.0, 5223.712695801767, 5263.894582137641, 6109.511239100772, 6237.625742455467, 6324.30432652417, 6301.779437719658, 6333.081703152925, 6375.043743438336, 6375.808725738235, 6386.457151142205, 6237.7193026314835, 6256.749730010749, 6259.718312676032, 6262.5929314594405, 6273.059041143682, 4956.405231372259, 5075.416327122428, 6081.969590152021, 6135.6932153393045, 6161.537884658758, 5030.597552195889, 6195.938040619716, 6202.658853763086, 6218.751249949952, 6238.407351301619, 5175.197844334134, 6104.236970378703, 6255.78104766331, 6282.1519094921605, 6302.401271879165, 6049.969750151221, 6117.3402608778015, 6121.300552271563, 6132.264128304632, 6167.259928808392], "unit": "score", "name": "dojo.html", "value": 5836.444994903014}, {"lowerIsBetter": false, "replicates": [531.455258360181, 600.9759609615616, 630.4483576870239, 682.7917485167025, 687.7145984416466, 38983.80508097459, 39290.82127536171, 39708.801455992754, 39725.60274397255, 39834.800825995866, 41354.345826166915, 41951.0, 41988.95027624311, 42012.57987420125, 42167.78916105415, 8001.519908805476, 9669.17811985982, 9797.26520510961, 9806.313558050939, 9849.704508864745, 9593.184579310768, 9790.853137202948, 9861.211103111735, 9878.308518403715, 9914.256430767686, 9833.508324583778, 9859.901400986006, 9925.2059835213, 9941.155001824853, 9962.651307204249, 9816.754581135458, 9829.70510884671, 9830.508474576278, 9850.901490985141, 9930.900690993107, 9789.0, 9900.356476829054, 9903.306768526207, 9912.157466615346, 9928.652497162637, 35318.823405883064, 41664.583354166374, 41864.581354186375, 41884.37173442401, 41938.58061419377, 3184.092533627928, 3419.145213696576, 3430.5368775215525, 3475.33968545978, 3607.7835329880027, 27871.581926271123, 28131.437371252665, 29042.12873613795, 29267.268318292, 29503.40993180146, 2708.8645567721733, 2809.8735556899987, 2821.7319354661277, 2889.2199106241405, 2981.7167369100116, 329609.0, 330663.0, 331795.0, 332483.0, 332776.0, 49028.0, 49433.0, 49442.0, 69297.0, 70875.0, 47199.292010619865, 47253.76373118113, 47502.0, 48156.0, 48227.276590851165, 17102.05938673385, 17105.657886842193, 17480.038597876985, 17612.823871761117, 17888.0, 13824.377902994389, 14001.0, 14040.859591403956, 14125.434982600786, 14147.787783183261, 15615.843841561438, 15705.450309239122, 15846.366145354057, 15851.207439627973, 15937.760933586005, 6492.902606460907, 6605.603663780189, 6626.966865165739, 6648.800535983928, 6698.363655452724, 923.9399439036441, 953.1659797677032, 1057.624543287122, 1083.913286937043, 1106.2919731371928, 27344.863275683496, 31190.220244493616, 31406.214844629067, 31423.37153256922, 32096.03711888647, 1208.6192849252457, 1221.3404761428906, 1261.6719652890315, 1262.6085913366885, 1313.678148853518, 15598.142102184262, 16031.038137711774, 16047.839521604634, 16195.0, 16253.106079165524, 501199.0, 525505.0, 529952.0, 534501.0, 535213.0, 51620.74189629103, 62535.37464625295, 63465.68267158727, 64429.67785161138, 64447.0, 1494.4395851555666, 1526.7328217561883, 1528.2435194578754, 1541.6993686231078, 1544.938202471911, 26393.472130557664, 30529.0, 30768.230794230323, 31242.531362029134, 32198.83900580482, 54423.72788136034, 54997.45002549923, 55070.89858202894, 55089.72455137699, 55749.44250557443, 411013.0, 418290.0, 422086.0, 497151.0, 499047.0, 35256.471152932216, 35947.10132246715, 36131.81934090313, 36216.637833621324, 36806.44790328094, 47415.0, 48126.518734812205, 48154.759226205046, 48374.0, 48995.0, 39086.6091339083, 40115.59884401118, 41183.0, 41335.586644134375, 42684.0, 39434.80282598569, 39683.80158099191, 39891.0, 40471.0, 41002.58997409988, 40451.59548404478, 40703.0, 41305.793471032455, 42191.0, 42207.577924220364, 30917.8454107737, 33476.163095921824, 33856.94235639036, 34478.48282275718, 34648.48027279542, 25776.0, 26754.0, 26757.86621066882, 26758.732412675625, 26912.0], "unit": "score", "name": "ext.html", "value": 19923.211842629928}, {"lowerIsBetter": false, "replicates": [380.0745185473371, 382.6364953294369, 387.86424751337034, 391.6553432978978, 394.19977445785065, 19771.209151633917, 20355.389338319837, 22321.33036008918, 22412.55174896503, 22689.886550567244, 19937.0, 21414.571708565818, 21832.89083554584, 22210.1115955362, 22649.773502264972, 5876.70616469177, 5894.0, 6054.394560543932, 6104.938950610482, 6147.7233524491285, 5956.076808094731, 5967.641941483504, 6031.638101713889, 6032.27612686476, 6052.364501727321, 5736.082226843706, 5851.824445266649, 5899.87902298564, 5989.490893274077, 6038.124471951564, 4930.654854160211, 5826.038703613898, 5831.416858314155, 5847.26909136358, 5953.0, 5161.61287903405, 5190.584753219733, 5214.8696282592855, 5239.659422137549, 5265.815696450644, 18954.24183032677, 26279.73720262792, 26548.93804247828, 26814.5977810333, 26864.59703104455, 2096.6854971754206, 2145.6459684152096, 2222.9555408891893, 2427.514497100587, 2456.803455723538, 15308.387664493406, 15529.301181446863, 15561.455349062728, 15585.0, 15874.0, 1487.4496436318632, 1828.5611453251256, 1867.6544839204792, 1907.0, 1930.1121484117323, 104684.42973355406, 107777.46111269394, 109353.89104280724, 110731.0, 111396.4430177852, 10740.78518429627, 11054.944725276322, 11182.832257516144, 11286.322820630789, 11332.263402878787, 11386.259893106922, 13615.910727141805, 13778.724425511433, 13834.377453014638, 13900.721985560434, 8889.19997200255, 8970.0, 9062.456252624863, 9162.770930726785, 9217.861732074025, 7592.354649854714, 9333.113354231336, 9439.008904065111, 9521.857172142423, 9527.857082143773, 6298.370162983665, 6463.353664633499, 6468.870622587522, 6469.902951455732, 6684.665766711645, 1788.7674602301618, 1891.564940063793, 1913.2920819296671, 1932.391296741522, 1938.331275709878, 417.22812796326554, 472.6974736168855, 978.9070038346346, 1010.7119470950744, 1125.786100640892, 10382.636607718845, 11886.465109070112, 12240.387980600934, 12495.812562811565, 12610.747785044248, 432.6409080463208, 472.6455158631027, 481.3814248690416, 487.77318546875165, 519.3196912045157, 6349.206349206349, 6372.776952806722, 6444.258910225384, 6458.6770661466735, 6525.086487891699, 679111.0, 679898.0, 689869.0, 696503.0, 699001.0, 93126.0, 115375.0, 121696.39151804184, 129010.0, 130504.0, 1035.3839465518004, 1062.8352605346183, 1071.5285274479204, 1073.4203530093819, 1086.1690806532852, 18011.369602063864, 18453.07734613237, 18490.16794244289, 19134.0, 19391.612167756848, 52451.68870778261, 53196.0, 54347.18479222736, 55590.88818223532, 55666.443335566124, 67855.98216026665, 69887.65056174686, 74620.25379746134, 75396.0, 77012.2298777005, 8404.117567655308, 8474.66101355939, 8655.518128794649, 8658.0, 8732.78168045804, 12920.095593308379, 13752.381142848795, 13798.241096739373, 14115.929420352833, 14153.575392738234, 11827.763444731228, 11904.702382440508, 11974.521019159136, 11991.580294689993, 12008.579699710468, 11496.0, 11588.6523404298, 11781.0, 11842.703932401759, 11948.223365481215, 11990.460429280529, 12030.518779248732, 12131.75736485283, 12176.695582610506, 12322.815157772462, 7425.851482970203, 7912.28789408956, 8424.0, 8504.362172837185, 8662.393632445921, 9129.680461183827, 11709.189635368197, 12000.63998080024, 12092.758144836878, 12166.330851803235], "unit": "score", "name": "jquery.html", "value": 9393.391437099379}, {"lowerIsBetter": false, "replicates": [1628.4951664983853, 1639.5245378840136, 1946.6204090202416, 2028.5667475908913, 2041.540653352995, 8319.209675080858, 9084.954575227122, 9134.862977055349, 9292.210162136218, 9294.209992150667, 8956.417832840862, 9080.409773364727, 9102.544872756369, 9209.815803683923, 9222.815543689123, 2576.5491039068183, 2577.471618318245, 2580.406506503505, 2609.9217023489327, 2617.306413800344, 2387.438951846315, 2392.007316963458, 2608.191460647196, 2623.121254379785, 2626.921192364232, 2319.9560197910923, 2504.2862784106533, 2598.2984594159566, 2604.127617248224, 2611.033917450546, 2593.1313010141625, 2593.6757905261843, 2599.2072417912527, 2612.451385209099, 2636.4595257972164, 2493.1453485758884, 2509.8619575923317, 2534.1510593951048, 2555.6038813983864, 2563.910263140781, 9242.676506322314, 9293.90706092944, 9326.860097098548, 9335.393199442082, 9342.2526197904, 5722.856928576777, 5724.370319264919, 5782.219400380936, 5900.940990590082, 5972.313183983811, 3696.907577310562, 3785.37541305687, 3835.8657446989223, 3842.8078596070363, 3851.5378154621344, 1074.2641290715885, 1091.4215465803138, 1092.3009274064605, 1133.846930664358, 1135.914806389524, 12066.879331206663, 12454.626361209179, 12494.625161245178, 12556.121071524996, 12570.811437828439, 4298.957010429918, 4479.574440428154, 5089.592832573385, 5091.745412729349, 5145.665531740425, 8782.824343513093, 10488.0, 10621.150307975344, 10674.252802303765, 10704.78590428187, 4837.564619184291, 5694.772209111589, 5702.173184888168, 5758.769649213985, 5864.472197502245, 4693.906121877611, 5159.613029022838, 5183.352080989876, 5238.528532432099, 5294.364676238876, 4110.630043296118, 4129.607687269705, 4147.0, 4183.895402614898, 4191.434156388909, 1349.568138195768, 1371.8010888421122, 1394.4143459746729, 1401.1102949626857, 1401.8948578856628, 1389.6248013036422, 1408.2677007955806, 1428.357239242345, 1446.5298777897226, 1479.9556013319618, 8595.0, 8616.913830861611, 8624.482531048157, 8632.870506942401, 8640.833487479236, 453.64162311773987, 503.62983207342575, 532.2654736463733, 549.0199993012453, 549.6647045302362, 6329.240491141, 6374.872502550016, 6421.903671444932, 6460.870782584322, 6508.0, 11246.718832029264, 11301.095912326995, 11533.653990380302, 11654.359010254517, 11694.47374868133, 10928.508217130247, 11153.051990580729, 11389.886101139049, 11412.258203216765, 11538.307701537935, 8849.557522123869, 8882.511461869659, 8893.510856902933, 8966.103389660982, 8967.865482017905, 7985.560794156378, 8275.462094963808, 8322.417430779788, 8358.03882553514, 8371.497710137412, 9826.16477599412, 9867.55595998196, 10093.19254459656, 10173.745656358651, 10237.795244095225, 7950.562719050276, 8603.0, 10105.444200568745, 10285.331453455501, 10334.173266138841, 7748.612569371621, 7760.573168475562, 7833.608319584112, 7849.803754906173, 7896.921030789618, 7202.243764404662, 8445.662173513236, 8623.784405389915, 8624.78438039054, 8697.91302086971, 7711.344535714527, 7732.188120247293, 7898.486598371088, 7945.0, 7987.520748755093, 7614.847703045797, 7706.306432421109, 7717.652705628372, 7747.72882949094, 7786.18245084258, 8122.878156827534, 8138.145494723206, 8157.79605509867, 8223.54770487629, 8237.588120594066, 6337.588056776295, 6413.422791948747, 7303.014093097577, 7325.706971721072, 7363.374113200223, 7287.1984081752025, 7418.517796343221, 7442.330190282901, 7516.962415187889, 7556.697732090654], "unit": "score", "name": "mootools.html", "value": 5068.489602255399}, {"lowerIsBetter": false, "replicates": [296.78483099752697, 344.21347221598637, 344.38871003967955, 347.7270342780916, 351.2430711816037, 6859.416949559293, 6929.3417125373135, 6945.062416573761, 6973.232944376121, 6989.580625162487, 5405.945940540603, 6824.249332573413, 6832.795016149524, 6837.145356830396, 6914.308569143083, 4448.466184057917, 4651.000034992476, 4938.333325001115, 5135.35808023997, 5227.451117632641, 4085.9387109193235, 5077.213031980049, 5112.693238405707, 5115.13042782726, 5128.07694614971, 5024.095662780698, 5063.6202284828605, 5073.771680274378, 5162.457941916101, 5167.896642067157, 5177.741112944356, 5179.119549676564, 5179.834537229131, 5190.584753219733, 5193.376794784613, 4425.269830477967, 4433.8226470941445, 4440.0, 4443.044745379759, 4451.1765323415275, 6427.967860160716, 6580.605163690194, 6584.9012264816065, 6605.504587155934, 6646.0, 5910.083936989773, 5973.372795856416, 5979.521638268928, 5986.670733109677, 5993.6104153230335, 7436.851262974765, 7446.329830315243, 7456.85086298271, 7472.738454154079, 7473.738419155304, 4802.807887684488, 4833.637477189225, 4834.323194752737, 4838.056578967103, 4843.321934929113, 7078.0, 7655.808604784925, 7760.107587627439, 7831.647575859043, 7854.3716502679645, 4810.4467986181335, 4883.706977581356, 4891.461939186686, 4906.55840974314, 4907.730074845917, 4936.851894443173, 4972.105021096238, 4986.351774269322, 4992.90014199714, 4993.350864387607, 4834.975825120852, 5959.642421454727, 5996.070609055603, 5997.0, 6028.4272994065495, 7451.180370159278, 7460.70157193717, 7469.514481558681, 7480.476366654282, 7481.738139165103, 1427.3006226948721, 1634.1992423712295, 1689.8732595055174, 1695.4828777223065, 1697.5416637507803, 1052.4369462337613, 1094.4965315954591, 1095.45774841454, 1099.7305660113323, 1101.251149218539, 6944.513884028171, 7045.225025247219, 7075.514142030129, 7102.325279098477, 7114.466415018895, 6252.937470625236, 7669.9616501917135, 7673.808154796175, 7690.192529784404, 7704.92295077042, 5199.324087868628, 7128.964355178191, 7167.3549380556, 7185.101862267216, 7188.784336469915, 4039.2527382434346, 4074.409210664437, 4095.52901416335, 4096.180763847243, 4101.91796164075, 7170.6056166910275, 7989.320907722792, 7997.600119993977, 8007.279344858991, 8013.398995075276, 6370.840728981812, 7630.504017238862, 7929.5242285463055, 7944.404169687296, 7978.401619878417, 7946.046474423106, 7958.3235424989525, 8014.799630009296, 8032.995875515444, 8035.879461808077, 7691.307782299396, 7706.884396734165, 7713.112992005991, 7727.11138219112, 7731.845363092594, 7590.8102297443, 7599.696012159673, 7603.619819009138, 7609.467337286337, 7623.580703061385, 7758.107817601048, 7982.441229113906, 8026.558539280396, 8036.4776289541, 8037.31682806968, 4853.39332583427, 4875.098106850244, 4895.241237608177, 4907.2393778964315, 4908.042931628441, 6873.5875847449315, 7108.537945033556, 7706.691732330644, 7726.729564465217, 7797.0, 7407.703691852265, 7436.107667079768, 7437.070366204224, 7456.813579660552, 7502.249775022454, 7158.713651453883, 7469.402447804271, 7490.101187857492, 7491.513051651626, 7503.362214211853, 7212.819679507845, 7252.601106939169, 7262.600556969206, 7308.524945878501, 7317.926820731937, 7467.850642987219, 7479.139898911695, 7485.251474852471, 7490.812729681802, 7492.550446973199, 7028.508004439845, 7259.6007219603425, 7311.707531698672, 7324.780256592311, 7357.0], "unit": "score", "name": "prototype.html", "value": 5391.4870401749085}, {"lowerIsBetter": false, "replicates": [718.5544962123481, 719.1478098453333, 746.0934964018716, 778.3345239819951, 781.6560713286152, 15709.62243117731, 15806.920965395186, 15927.044377337368, 15927.283272252747, 16010.43963461279, 14563.417463301455, 14601.0, 14615.707685846277, 14616.4884229052, 14658.706825863477, 781.0861292288008, 981.4503877828404, 985.9556319965601, 1008.2639673038686, 1008.5915204342253, 966.7631430299587, 975.2490582251662, 979.7109852593502, 990.6681261777313, 993.9503024848765, 1015.4313584392727, 1047.1779652972418, 1059.2108878885242, 1059.3537941855461, 1060.835570486572, 1034.7723500829843, 1038.7299302181411, 1042.9843552346722, 1051.5215576912487, 1056.1603525197486, 741.7774667599753, 742.1835980421547, 746.8991686122358, 752.766642340876, 763.084298841387, 15288.694226115414, 15305.540833775005, 15321.693566128726, 15334.156621385819, 15644.843551564452, 13386.799198012037, 13452.394642241123, 13462.730745385037, 13538.458461661521, 13581.320933953262, 10380.948095259475, 10457.84313235302, 10469.895301046969, 10472.895271047268, 10537.473126343652, 3636.236390358028, 3642.3261696586214, 3645.3620616392027, 3683.6684698377007, 3724.6647801697977, 83832.0, 85590.57204713998, 85706.0, 85926.0, 86531.56734216351, 7460.250106082941, 7484.363829074481, 8959.283257339397, 9089.318301127441, 9165.33853662418, 17055.147242637817, 20426.38720838377, 20585.588288234452, 20596.485087872923, 20776.27283045086, 6559.573627714183, 6647.833804154935, 7716.344110750649, 7741.535507869546, 8007.399445041645, 4293.8711838644895, 4366.563343665608, 4371.0, 4426.84506042287, 4430.778461076933, 3717.386631205875, 3724.497192878981, 3747.5690295616355, 3757.9436308455397, 3764.4917936078277, 710.3748701142961, 717.2074857282731, 721.5670597641373, 723.7466886589651, 738.6380673470069, 468.3910915809434, 525.2882344423327, 608.57703895792, 616.0881894795727, 619.454879705856, 7909.446338756232, 8052.194780521901, 8052.798680033046, 8302.54336011525, 8420.200080992296, 572.2160639923331, 607.2197226563844, 620.525298146918, 628.136312570216, 630.7760744935573, 3947.703922205846, 3985.561588225351, 4004.3593025115842, 4031.7984100794843, 4202.537720850704, 89949.0, 91582.0, 91929.62105568421, 92808.0, 93265.5336723312, 77117.22882771213, 77436.0, 78563.0, 79039.0, 79147.41705165865, 67021.66489167523, 67700.0, 69824.3017569828, 70134.59730805355, 71283.28716712767, 7862.960685196537, 7990.720324788605, 8106.8783968241705, 8288.129746376784, 8437.367197460339, 46808.76595617, 47020.529794701615, 47468.52531474779, 48131.75934120447, 49407.75296123496, 49748.253776192665, 64479.0, 66251.0, 66663.00005499825, 68041.0, 11147.386893720599, 11539.249948753304, 11544.19190656646, 11666.183367164556, 11776.411179441166, 12248.938755306166, 12343.321117338273, 12376.938115309365, 12400.875991239973, 12832.29422381778, 11810.527578896748, 12003.039756819258, 12046.518139274682, 12090.818637720266, 12363.0, 11691.123165762432, 11855.644330670093, 12027.699307517032, 12049.554053513635, 12099.0, 11714.648560543197, 11736.94131529371, 11816.645500634651, 11832.0, 11981.700457488632, 9542.284328675238, 9868.457234851865, 10064.647737329158, 10103.848442273225, 10282.897171028193, 9826.606935722491, 10185.33795303303, 10206.132478739093, 10257.74355641115, 10261.435621040615], "unit": "score", "name": "yui.html", "value": 7107.248882371752}], "name": "dromaeo_css", "value": 7722.8072867115225}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 110.0, 116.0, 118.0, 117.0, 131.0, 114.0, 118.0, 159.0, 168.0], "unit": "score", "name": "ai-astar", "value": 126.6}, {"lowerIsBetter": true, "replicates": [149.0, 122.0, 152.0, 144.0, 119.0, 154.0, 169.0, 125.0, 181.0, 147.0], "unit": "score", "name": "audio-beat-detection", "value": 146.2}, {"lowerIsBetter": true, "replicates": [271.0, 196.0, 184.0, 267.0, 202.0, 188.0, 174.0, 259.0, 187.0, 172.0], "unit": "score", "name": "audio-dft", "value": 210.0}, {"lowerIsBetter": true, "replicates": [66.0, 75.0, 60.0, 112.0, 48.0, 68.0, 59.0, 52.0, 141.0, 83.0], "unit": "score", "name": "audio-fft", "value": 76.4}, {"lowerIsBetter": true, "replicates": [82.0, 82.0, 116.0, 81.0, 97.0, 72.0, 105.0, 75.0, 107.0, 152.0], "unit": "score", "name": "audio-oscillator", "value": 96.9}, {"lowerIsBetter": true, "replicates": [89.0, 86.0, 88.0, 86.0, 89.0, 85.0, 89.0, 85.0, 88.0, 108.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 89.3}, {"lowerIsBetter": true, "replicates": [92.0, 95.0, 94.0, 95.0, 95.0, 117.0, 149.0, 123.0, 136.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 114.3}, {"lowerIsBetter": true, "replicates": [91.0, 94.0, 128.0, 149.0, 98.0, 98.0, 92.0, 90.0, 90.0, 91.0], "unit": "score", "name": "imaging-desaturate", "value": 102.1}, {"lowerIsBetter": true, "replicates": [54.0, 57.0, 59.0, 58.0, 57.0, 60.0, 61.0, 59.0, 59.0, 66.0], "unit": "score", "name": "json-parse-financial", "value": 59.0}, {"lowerIsBetter": true, "replicates": [64.0, 107.0, 70.0, 62.0, 88.0, 95.0, 64.0, 65.0, 65.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 74.5}, {"lowerIsBetter": true, "replicates": [82.0, 83.0, 83.0, 83.0, 82.0, 81.0, 80.0, 83.0, 80.0, 87.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.4}, {"lowerIsBetter": true, "replicates": [129.0, 121.0, 140.0, 135.0, 139.0, 135.0, 122.0, 120.0, 130.0, 138.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 130.9}, {"lowerIsBetter": true, "replicates": [136.0, 135.0, 142.0, 151.0, 139.0, 140.0, 138.0, 134.0, 137.0, 125.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 137.7}, {"lowerIsBetter": true, "replicates": [68.0, 66.0, 68.0, 66.0, 69.0, 67.0, 67.0, 68.0, 66.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.0}], "name": "kraken", "value": 1513.3}]} 05:56:13 INFO - Return code: 0 05:56:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:56:13 ERROR - # TBPL SUCCESS # 05:56:13 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:56:13 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:56:13 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:56:13 INFO - 2016-05-09 05:56:13.976 screenresolution[1687:10801] starting screenresolution argv=screenresolution get 05:56:13 INFO - 2016-05-09 05:56:13.979 screenresolution[1687:10801] Display 0: 1600x1200x32@60 05:56:13 INFO - 2016-05-09 05:56:13.985 screenresolution[1688:10804] starting screenresolution argv=screenresolution list 05:56:13 INFO - Available Modes on Display 0 05:56:13 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:56:13 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:56:13 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:56:13 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:56:14 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:56:14 INFO - Intel Iris: 05:56:14 INFO - Chipset Model: Intel Iris 05:56:14 INFO - Type: GPU 05:56:14 INFO - Bus: Built-In 05:56:14 INFO - VRAM (Dynamic, Max): 1536 MB 05:56:14 INFO - Vendor: Intel (0x8086) 05:56:14 INFO - Device ID: 0x0a2e 05:56:14 INFO - Revision ID: 0x0009 05:56:14 INFO - Displays: 05:56:14 INFO - Display: 05:56:14 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:56:14 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:56:14 INFO - Display Serial Number: 1600x1200 60 05:56:14 INFO - Main Display: Yes 05:56:14 INFO - Mirror: Off 05:56:14 INFO - Online: Yes 05:56:14 INFO - Rotation: Supported 05:56:14 INFO - Return code: 0 05:56:14 INFO - Running post-action listener: _resource_record_post_action 05:56:14 INFO - Running post-run listener: _resource_record_post_run 05:56:15 INFO - Total resource usage - Wall time: 1191s; CPU: 53.0%; Read bytes: 37737984; Write bytes: 512989696; Read time: 400; Write time: 1733 05:56:15 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 198613504; Write bytes: 200521216; Read time: 18002; Write time: 431 05:56:15 INFO - run-tests - Wall time: 1169s; CPU: 53.0%; Read bytes: 36783616; Write bytes: 302511104; Read time: 379; Write time: 1267 05:56:15 INFO - Running post-run listener: _upload_blobber_files 05:56:15 INFO - Blob upload gear active. 05:56:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:56:15 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 05:56:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:56:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:56:15 INFO - (blobuploader) - INFO - Open directory for files ... 05:56:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:56:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:56:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:56:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:56:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:56:16 INFO - (blobuploader) - INFO - Done attempting. 05:56:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:56:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:56:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:56:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:56:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:56:17 INFO - (blobuploader) - INFO - Done attempting. 05:56:17 INFO - (blobuploader) - INFO - Iteration through files over. 05:56:17 INFO - Return code: 0 05:56:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:56:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:56:17 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/99ccf46e539588559cb1df09aea6c9471674c0b2f0b88ba57ed26162d8f294dbff8409b268675043ffbc676a71cec8e373806de3f5fd66f38840493681ca6bbb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3a6d9184f8c29c74eba31be9b66004b16a5b97a24a85baedb659ea6a4b18de3ff2679bf3d9d0fa68b63d0b48f5821b4d16eba38bb688668fe8e427311cdb3943"} 05:56:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:56:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:56:17 INFO - Contents: 05:56:17 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/99ccf46e539588559cb1df09aea6c9471674c0b2f0b88ba57ed26162d8f294dbff8409b268675043ffbc676a71cec8e373806de3f5fd66f38840493681ca6bbb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3a6d9184f8c29c74eba31be9b66004b16a5b97a24a85baedb659ea6a4b18de3ff2679bf3d9d0fa68b63d0b48f5821b4d16eba38bb688668fe8e427311cdb3943"} 05:56:17 INFO - Running post-run listener: copy_logs_to_upload_dir 05:56:17 INFO - Copying logs to upload dir... 05:56:17 INFO - mkdir: /builds/slave/test/build/upload/logs 05:56:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.760715 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-05-09 05:56:17.787910) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-09 05:56:17.791959) ========= 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: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.kS6Wx5JK3f/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test/properties RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.QabMDETVzg/Listeners TMPDIR=/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/99ccf46e539588559cb1df09aea6c9471674c0b2f0b88ba57ed26162d8f294dbff8409b268675043ffbc676a71cec8e373806de3f5fd66f38840493681ca6bbb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3a6d9184f8c29c74eba31be9b66004b16a5b97a24a85baedb659ea6a4b18de3ff2679bf3d9d0fa68b63d0b48f5821b4d16eba38bb688668fe8e427311cdb3943"} build_url:https://queue.taskcluster.net/v1/task/D_vUHmeKR_2mA7juCS2aMw/artifacts/public/build/firefox-47.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011481 build_url: 'https://queue.taskcluster.net/v1/task/D_vUHmeKR_2mA7juCS2aMw/artifacts/public/build/firefox-47.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/99ccf46e539588559cb1df09aea6c9471674c0b2f0b88ba57ed26162d8f294dbff8409b268675043ffbc676a71cec8e373806de3f5fd66f38840493681ca6bbb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3a6d9184f8c29c74eba31be9b66004b16a5b97a24a85baedb659ea6a4b18de3ff2679bf3d9d0fa68b63d0b48f5821b4d16eba38bb688668fe8e427311cdb3943"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-09 05:56:17.820047) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 05:56:17.820375) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.kS6Wx5JK3f/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.QabMDETVzg/Listeners TMPDIR=/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005148 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 05:56:17.871132) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-09 05:56:17.871611) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-09 05:56:17.872105) ========= ========= Total master_lag: 0.15 =========