builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0115 starttime: 1467053305.93 results: success (0) buildid: 20160627094317 builduid: 59e32d1fac0b4cb482da14c713334a08 revision: 00a6e2ca6e9ab22fe9cbacf4cec52315a8b38b47 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 11:48:25.933489) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 11:48:25.933941) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 11:48:25.934216) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 11:48:25.958385) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 11:48:25.958678) ========= 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.XoXgwXe5Id/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.kgf8dWzmOp/Listeners TMPDIR=/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/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-06-27 11:48:25-- 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% 148M=0s 2016-06-27 11:48:26 (148 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.123286 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 11:48:26.104309) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 11:48:26.104634) ========= 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.XoXgwXe5Id/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.kgf8dWzmOp/Listeners TMPDIR=/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/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.031991 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 11:48:26.156677) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 11:48:26.157024) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 00a6e2ca6e9ab22fe9cbacf4cec52315a8b38b47 --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 00a6e2ca6e9ab22fe9cbacf4cec52315a8b38b47 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.XoXgwXe5Id/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.kgf8dWzmOp/Listeners TMPDIR=/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/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-06-27 11:48:26,231 truncating revision to first 12 chars 2016-06-27 11:48:26,231 Setting DEBUG logging. 2016-06-27 11:48:26,231 attempt 1/10 2016-06-27 11:48:26,231 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/00a6e2ca6e9a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-27 11:48:26,908 unpacking tar archive at: mozilla-beta-00a6e2ca6e9a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.937561 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 11:48:27.116064) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 11:48:27.116461) ========= script_repo_revision: 00a6e2ca6e9ab22fe9cbacf4cec52315a8b38b47 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 11:48:27.116890) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 11:48:27.117165) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 11:48:27.134913) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2016-06-27 11:48:27.135330) ========= /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.XoXgwXe5Id/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.kgf8dWzmOp/Listeners TMPDIR=/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/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 11:48:27 INFO - MultiFileLogger online at 20160627 11:48:27 in /builds/slave/test 11:48:27 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 11:48:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:48:27 INFO - {'append_to_log': False, 11:48:27 INFO - 'base_work_dir': '/builds/slave/test', 11:48:27 INFO - 'blob_upload_branch': 'Mozilla-Beta', 11:48:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:48:27 INFO - 'branch': 'Mozilla-Beta', 11:48:27 INFO - 'buildbot_json_path': 'buildprops.json', 11:48:27 INFO - 'config_files': ('talos/mac_config.py',), 11:48:27 INFO - 'default_actions': ('clobber', 11:48:27 INFO - 'read-buildbot-config', 11:48:27 INFO - 'download-and-extract', 11:48:27 INFO - 'populate-webroot', 11:48:27 INFO - 'create-virtualenv', 11:48:27 INFO - 'install', 11:48:27 INFO - 'run-tests'), 11:48:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:48:27 INFO - 'download_minidump_stackwalk': True, 11:48:27 INFO - 'download_symbols': 'ondemand', 11:48:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:48:27 INFO - 'tooltool.py': '/tools/tooltool.py', 11:48:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:48:27 INFO - '/tools/misc-python/virtualenv.py')}, 11:48:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:48:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:48:27 INFO - 'installer_path': 'installer.exe', 11:48:27 INFO - 'log_level': 'info', 11:48:27 INFO - 'log_name': 'talos', 11:48:27 INFO - 'log_to_console': True, 11:48:27 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:48:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:48:27 INFO - 'opt_config_files': (), 11:48:27 INFO - 'pip_index': False, 11:48:27 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:48:27 INFO - 'cmd': ('bash', 11:48:27 INFO - '-c', 11:48:27 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:48:27 INFO - 'enabled': True, 11:48:27 INFO - 'halt_on_failure': False, 11:48:27 INFO - 'name': 'check_screen_resolution'},), 11:48:27 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:48:27 INFO - 'cmd': ('bash', 11:48:27 INFO - '-c', 11:48:27 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:48:27 INFO - 'enabled': True, 11:48:27 INFO - 'halt_on_failure': False, 11:48:27 INFO - 'name': 'check_screen_resolution'},), 11:48:27 INFO - 'run_cmd_checks_enabled': True, 11:48:27 INFO - 'sps_profile': False, 11:48:27 INFO - 'sps_profile_interval': 0, 11:48:27 INFO - 'suite': 'dromaeojs-e10s', 11:48:27 INFO - 'system_bits': '32', 11:48:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:48:27 INFO - 'title': 't-yosemite-r7-0115', 11:48:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:48:27 INFO - 'use_talos_json': True, 11:48:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:48:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:48:27 INFO - 'work_dir': 'build'} 11:48:27 INFO - ##### 11:48:27 INFO - ##### Running clobber step. 11:48:27 INFO - ##### 11:48:27 INFO - Running pre-action listener: _resource_record_pre_action 11:48:27 INFO - Running main action method: clobber 11:48:27 INFO - rmtree: /builds/slave/test/build 11:48:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:48:29 INFO - Running post-action listener: _resource_record_post_action 11:48:29 INFO - ##### 11:48:29 INFO - ##### Running read-buildbot-config step. 11:48:29 INFO - ##### 11:48:29 INFO - Running pre-action listener: _resource_record_pre_action 11:48:29 INFO - Running main action method: read_buildbot_config 11:48:29 INFO - Using buildbot properties: 11:48:29 INFO - { 11:48:29 INFO - "project": "", 11:48:29 INFO - "product": "firefox", 11:48:29 INFO - "script_repo_revision": "production", 11:48:29 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 11:48:29 INFO - "repository": "", 11:48:29 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 11:48:29 INFO - "buildid": "20160627094317", 11:48:29 INFO - "pgo_build": "False", 11:48:29 INFO - "basedir": "/builds/slave/test", 11:48:29 INFO - "buildnumber": 17, 11:48:29 INFO - "slavename": "t-yosemite-r7-0115", 11:48:29 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 11:48:29 INFO - "platform": "yosemite_r7", 11:48:29 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 11:48:29 INFO - "branch": "mozilla-beta", 11:48:29 INFO - "repo_path": "releases/mozilla-beta", 11:48:29 INFO - "revision": "00a6e2ca6e9ab22fe9cbacf4cec52315a8b38b47", 11:48:29 INFO - "stage_platform": "macosx64", 11:48:29 INFO - "builduid": "59e32d1fac0b4cb482da14c713334a08", 11:48:29 INFO - "slavebuilddir": "test" 11:48:29 INFO - } 11:48:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/MzxqhptITsu9WN-TocNehg/artifacts/public/build/firefox-48.0.en-US.mac.dmg. 11:48:29 INFO - Running post-action listener: _resource_record_post_action 11:48:29 INFO - ##### 11:48:29 INFO - ##### Running download-and-extract step. 11:48:29 INFO - ##### 11:48:29 INFO - Running pre-action listener: _resource_record_pre_action 11:48:29 INFO - Running main action method: download_and_extract 11:48:29 INFO - mkdir: /builds/slave/test/build/tests 11:48:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:48:29 INFO - https://queue.taskcluster.net/v1/task/MzxqhptITsu9WN-TocNehg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 11:48:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MzxqhptITsu9WN-TocNehg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 11:48:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MzxqhptITsu9WN-TocNehg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 11:48:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MzxqhptITsu9WN-TocNehg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 11:48:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MzxqhptITsu9WN-TocNehg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json'}, attempt #1 11:48:46 INFO - Downloaded 1165 bytes. 11:48:46 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 11:48:46 INFO - Using the following test package requirements: 11:48:46 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 11:48:46 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 11:48:46 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 11:48:46 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 11:48:46 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 11:48:46 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 11:48:46 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 11:48:46 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 11:48:46 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 11:48:46 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 11:48:46 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 11:48:46 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 11:48:46 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 11:48:46 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 11:48:46 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 11:48:46 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 11:48:46 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 11:48:46 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 11:48:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:48:46 INFO - https://queue.taskcluster.net/v1/task/MzxqhptITsu9WN-TocNehg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 11:48:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MzxqhptITsu9WN-TocNehg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 11:48:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MzxqhptITsu9WN-TocNehg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 11:48:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MzxqhptITsu9WN-TocNehg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 11:48:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MzxqhptITsu9WN-TocNehg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 11:49:01 INFO - Downloaded 18350413 bytes. 11:49:01 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:49:01 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 11:49:04 INFO - Return code: 0 11:49:04 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip', u'firefox-48.0.en-US.mac.talos.tests.zip'] for test suite category: talos 11:49: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')]} 11:49:04 INFO - https://queue.taskcluster.net/v1/task/MzxqhptITsu9WN-TocNehg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 11:49:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MzxqhptITsu9WN-TocNehg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 11:49:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MzxqhptITsu9WN-TocNehg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 11:49:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MzxqhptITsu9WN-TocNehg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 11:49:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MzxqhptITsu9WN-TocNehg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 11:49:08 INFO - Downloaded 18350413 bytes. 11:49:08 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:49:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 11:49:12 INFO - Return code: 0 11:49:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:49:12 INFO - https://queue.taskcluster.net/v1/task/MzxqhptITsu9WN-TocNehg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 11:49:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MzxqhptITsu9WN-TocNehg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 11:49:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MzxqhptITsu9WN-TocNehg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 11:49:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MzxqhptITsu9WN-TocNehg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip 11:49:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MzxqhptITsu9WN-TocNehg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip'}, attempt #1 11:49:13 INFO - Downloaded 10840145 bytes. 11:49:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:49:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 11:49:13 INFO - Return code: 0 11:49:13 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')]} 11:49:13 INFO - https://queue.taskcluster.net/v1/task/MzxqhptITsu9WN-TocNehg/artifacts/public/build/firefox-48.0.en-US.mac.dmg matches https://queue.taskcluster.net 11:49:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MzxqhptITsu9WN-TocNehg/artifacts/public/build/firefox-48.0.en-US.mac.dmg 11:49:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MzxqhptITsu9WN-TocNehg/artifacts/public/build/firefox-48.0.en-US.mac.dmg 11:49:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MzxqhptITsu9WN-TocNehg/artifacts/public/build/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 11:49:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MzxqhptITsu9WN-TocNehg/artifacts/public/build/firefox-48.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg'}, attempt #1 11:49:18 INFO - Downloaded 86200278 bytes. 11:49:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MzxqhptITsu9WN-TocNehg/artifacts/public/build/firefox-48.0.en-US.mac.dmg 11:49:18 INFO - mkdir: /builds/slave/test/properties 11:49:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:49:18 INFO - Writing to file /builds/slave/test/properties/build_url 11:49:18 INFO - Contents: 11:49:18 INFO - build_url:https://queue.taskcluster.net/v1/task/MzxqhptITsu9WN-TocNehg/artifacts/public/build/firefox-48.0.en-US.mac.dmg 11:49:19 INFO - Running post-action listener: _resource_record_post_action 11:49:19 INFO - Running post-action listener: set_extra_try_arguments 11:49:19 INFO - ##### 11:49:19 INFO - ##### Running populate-webroot step. 11:49:19 INFO - ##### 11:49:19 INFO - Running pre-action listener: _resource_record_pre_action 11:49:19 INFO - Running main action method: populate_webroot 11:49:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:49:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:49:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:49:19 INFO - '--tppagecycles', 11:49:19 INFO - '7'], 11:49:19 INFO - 'tests': ['tsvgm']}}, 11:49:19 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:49:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:49:19 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:49:19 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:49:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:49:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:49:19 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:49:19 INFO - 'talos_options': ['--disable-e10s'], 11:49:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:49:19 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:49:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:49:19 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:49:19 INFO - 'talos_options': ['--disable-e10s'], 11:49:19 INFO - 'tests': ['damp', 'tps']}, 11:49:19 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:49:19 INFO - 'tests': ['damp', 'tps']}, 11:49:19 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:49:19 INFO - 'tests': ['dromaeo_dom']}, 11:49:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:49:19 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:49:19 INFO - 'tests': ['a11yr', 11:49:19 INFO - 'ts_paint', 11:49:19 INFO - 'tpaint', 11:49:19 INFO - 'sessionrestore', 11:49:19 INFO - 'sessionrestore_no_auto_restore', 11:49:19 INFO - 'tabpaint']}, 11:49:19 INFO - 'other-e10s': {'tests': ['a11yr', 11:49:19 INFO - 'ts_paint', 11:49:19 INFO - 'tpaint', 11:49:19 INFO - 'sessionrestore', 11:49:19 INFO - 'sessionrestore_no_auto_restore', 11:49:19 INFO - 'tabpaint']}, 11:49:19 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:49:19 INFO - 'ts_paint', 11:49:19 INFO - 'tpaint', 11:49:19 INFO - 'sessionrestore', 11:49:19 INFO - 'sessionrestore_no_auto_restore', 11:49:19 INFO - 'tabpaint']}, 11:49:19 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:49:19 INFO - 'ts_paint', 11:49:19 INFO - 'tpaint', 11:49:19 INFO - 'sessionrestore', 11:49:19 INFO - 'sessionrestore_no_auto_restore', 11:49:19 INFO - 'tabpaint']}, 11:49:19 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:49:19 INFO - 'tests': ['a11yr', 11:49:19 INFO - 'ts_paint', 11:49:19 INFO - 'tpaint', 11:49:19 INFO - 'sessionrestore', 11:49:19 INFO - 'sessionrestore_no_auto_restore', 11:49:19 INFO - 'tabpaint']}, 11:49:19 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:49:19 INFO - 'tests': ['a11yr', 11:49:19 INFO - 'ts_paint', 11:49:19 INFO - 'tpaint', 11:49:19 INFO - 'sessionrestore', 11:49:19 INFO - 'sessionrestore_no_auto_restore', 11:49:19 INFO - 'tabpaint']}, 11:49:19 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:49:19 INFO - 'tests': ['tsvgx', 11:49:19 INFO - 'tsvgr_opacity', 11:49:19 INFO - 'tart', 11:49:19 INFO - 'tscrollx', 11:49:19 INFO - 'cart']}, 11:49:19 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:49:19 INFO - 'tsvgr_opacity', 11:49:19 INFO - 'tart', 11:49:19 INFO - 'tscrollx', 11:49:19 INFO - 'cart']}, 11:49:19 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:49:19 INFO - 'talos_options': ['--disable-e10s'], 11:49:19 INFO - 'tests': ['tp5o']}, 11:49:19 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:49:19 INFO - 'tests': ['tp5o']}, 11:49:19 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:49:19 INFO - 'talos_options': ['--disable-e10s', 11:49:19 INFO - '--xperf_path', 11:49:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:49:19 INFO - 'tests': ['tp5n']}, 11:49:19 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:49:19 INFO - 'talos_options': ['--xperf_path', 11:49:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:49:19 INFO - 'tests': ['tp5n']}}, 11:49:19 INFO - 'talos.zip': {'path': '', 11:49:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:49:19 INFO - Running post-action listener: _resource_record_post_action 11:49:19 INFO - ##### 11:49:19 INFO - ##### Running create-virtualenv step. 11:49:19 INFO - ##### 11:49:19 INFO - Running pre-action listener: _resource_record_pre_action 11:49:19 INFO - Running main action method: create_virtualenv 11:49:19 INFO - Creating virtualenv /builds/slave/test/build/venv 11:49:19 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 11:49:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:49:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:49:19 INFO - Using real prefix '/tools/python27' 11:49:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:49:20 INFO - Installing distribute.............................................................................................................................................................................................done. 11:49:23 INFO - Installing pip.................done. 11:49:23 INFO - Return code: 0 11:49:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:49:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:49:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:49:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:49:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:49:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:23 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 0x10613da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10614d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9af3cb7f60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105fdce00>, '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 0x105e45db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105fd7b20>, '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.XoXgwXe5Id/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.kgf8dWzmOp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/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 11:49:23 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 11:49:23 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 11:49:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XoXgwXe5Id/Render', 11:49:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:49:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:49:23 INFO - 'HOME': '/Users/cltbld', 11:49:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:49:23 INFO - 'LOGNAME': 'cltbld', 11:49:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:23 INFO - 'MOZ_NO_REMOTE': '1', 11:49:23 INFO - 'NO_EM_RESTART': '1', 11:49:23 INFO - 'PAGER': '/bin/cat', 11:49:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:49:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:23 INFO - 'PWD': '/builds/slave/test', 11:49:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:49:23 INFO - 'SHELL': '/bin/bash', 11:49:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kgf8dWzmOp/Listeners', 11:49:23 INFO - 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/', 11:49:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:49:23 INFO - 'USER': 'cltbld', 11:49:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:49:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:49:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:23 INFO - 'XPC_FLAGS': '0x0', 11:49:23 INFO - 'XPC_SERVICE_NAME': '0', 11:49:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:49:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:49:23 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 11:49:23 INFO - Cleaning up... 11:49:23 INFO - Return code: 0 11:49:23 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 11:49:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:49:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:49:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:49:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:49:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:23 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 0x10613da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10614d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9af3cb7f60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105fdce00>, '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 0x105e45db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105fd7b20>, '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.XoXgwXe5Id/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.kgf8dWzmOp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/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 11:49:23 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 11:49:23 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 11:49:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XoXgwXe5Id/Render', 11:49:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:49:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:49:23 INFO - 'HOME': '/Users/cltbld', 11:49:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:49:23 INFO - 'LOGNAME': 'cltbld', 11:49:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:23 INFO - 'MOZ_NO_REMOTE': '1', 11:49:23 INFO - 'NO_EM_RESTART': '1', 11:49:23 INFO - 'PAGER': '/bin/cat', 11:49:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:49:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:23 INFO - 'PWD': '/builds/slave/test', 11:49:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:49:23 INFO - 'SHELL': '/bin/bash', 11:49:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kgf8dWzmOp/Listeners', 11:49:23 INFO - 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/', 11:49:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:49:23 INFO - 'USER': 'cltbld', 11:49:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:49:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:49:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:23 INFO - 'XPC_FLAGS': '0x0', 11:49:23 INFO - 'XPC_SERVICE_NAME': '0', 11:49:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:49:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:49:24 INFO - Downloading/unpacking psutil>=0.7.1 11:49:24 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 11:49:24 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 11:49:24 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 11:49:24 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 11:49:24 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 11:49:24 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 11:49:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:49:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:49:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:49:26 INFO - Installing collected packages: psutil 11:49:26 INFO - Running setup.py install for psutil 11:49:26 INFO - building 'psutil._psutil_osx' extension 11:49:26 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 11:49:27 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 11:49:27 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 11:49:27 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 11:49:27 INFO - building 'psutil._psutil_posix' extension 11:49:27 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 11:49:27 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:49:27 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:49:27 INFO - ^ 11:49:27 INFO - 1 warning generated. 11:49:27 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 11:49:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:49:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:49:28 INFO - Successfully installed psutil 11:49:28 INFO - Cleaning up... 11:49:28 INFO - Return code: 0 11:49:28 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:49:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:49:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:49:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:49:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:49:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:28 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 0x10613da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10614d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9af3cb7f60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105fdce00>, '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 0x105e45db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105fd7b20>, '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.XoXgwXe5Id/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.kgf8dWzmOp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/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 11:49:28 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 11:49:28 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 11:49:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XoXgwXe5Id/Render', 11:49:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:49:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:49:28 INFO - 'HOME': '/Users/cltbld', 11:49:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:49:28 INFO - 'LOGNAME': 'cltbld', 11:49:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:28 INFO - 'MOZ_NO_REMOTE': '1', 11:49:28 INFO - 'NO_EM_RESTART': '1', 11:49:28 INFO - 'PAGER': '/bin/cat', 11:49:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:49:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:28 INFO - 'PWD': '/builds/slave/test', 11:49:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:49:28 INFO - 'SHELL': '/bin/bash', 11:49:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kgf8dWzmOp/Listeners', 11:49:28 INFO - 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/', 11:49:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:49:28 INFO - 'USER': 'cltbld', 11:49:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:49:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:49:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:28 INFO - 'XPC_FLAGS': '0x0', 11:49:28 INFO - 'XPC_SERVICE_NAME': '0', 11:49:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:49:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:49:28 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:49:28 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 11:49:28 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 11:49:28 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 11:49:28 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 11:49:28 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 11:49:28 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 11:49:31 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:49:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:49:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:49:31 INFO - Installing collected packages: mozsystemmonitor 11:49:31 INFO - Running setup.py install for mozsystemmonitor 11:49:31 INFO - Successfully installed mozsystemmonitor 11:49:31 INFO - Cleaning up... 11:49:31 INFO - Return code: 0 11:49:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:49:31 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')]} 11:49:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:49:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:31 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')]} 11:49:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:49:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:31 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 0x10613da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10614d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9af3cb7f60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105fdce00>, '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 0x105e45db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105fd7b20>, '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.XoXgwXe5Id/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.kgf8dWzmOp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/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 11:49:31 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 11:49:31 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 11:49:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XoXgwXe5Id/Render', 11:49:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:49:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:49:31 INFO - 'HOME': '/Users/cltbld', 11:49:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:49:31 INFO - 'LOGNAME': 'cltbld', 11:49:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:31 INFO - 'MOZ_NO_REMOTE': '1', 11:49:31 INFO - 'NO_EM_RESTART': '1', 11:49:31 INFO - 'PAGER': '/bin/cat', 11:49:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:49:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:31 INFO - 'PWD': '/builds/slave/test', 11:49:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:49:31 INFO - 'SHELL': '/bin/bash', 11:49:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kgf8dWzmOp/Listeners', 11:49:31 INFO - 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/', 11:49:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:49:31 INFO - 'USER': 'cltbld', 11:49:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:49:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:49:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:31 INFO - 'XPC_FLAGS': '0x0', 11:49:31 INFO - 'XPC_SERVICE_NAME': '0', 11:49:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:49:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:49:31 INFO - Downloading/unpacking blobuploader==1.2.4 11:49:31 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 11:49:31 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 11:49:31 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 11:49:31 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 11:49:31 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 11:49:31 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 11:49:34 INFO - Downloading blobuploader-1.2.4.tar.gz 11:49:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:49:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:49:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:49:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:49:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:49:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:49:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:49:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:49:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:49:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:49:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:49:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:49:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:49:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:49:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:49:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:49:35 INFO - Downloading docopt-0.6.1.tar.gz 11:49:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:49:35 INFO - Installing collected packages: blobuploader, requests, docopt 11:49:35 INFO - Running setup.py install for blobuploader 11:49:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:49:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:49:35 INFO - Running setup.py install for requests 11:49:36 INFO - Running setup.py install for docopt 11:49:36 INFO - Successfully installed blobuploader requests docopt 11:49:36 INFO - Cleaning up... 11:49:36 INFO - Return code: 0 11:49:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:49:36 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')]} 11:49:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:49:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:36 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')]} 11:49:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:49:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:36 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 0x10613da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10614d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9af3cb7f60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105fdce00>, '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 0x105e45db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105fd7b20>, '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.XoXgwXe5Id/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.kgf8dWzmOp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/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 11:49:36 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 11:49:36 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 11:49:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XoXgwXe5Id/Render', 11:49:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:49:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:49:36 INFO - 'HOME': '/Users/cltbld', 11:49:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:49:36 INFO - 'LOGNAME': 'cltbld', 11:49:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:36 INFO - 'MOZ_NO_REMOTE': '1', 11:49:36 INFO - 'NO_EM_RESTART': '1', 11:49:36 INFO - 'PAGER': '/bin/cat', 11:49:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:49:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:36 INFO - 'PWD': '/builds/slave/test', 11:49:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:49:36 INFO - 'SHELL': '/bin/bash', 11:49:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kgf8dWzmOp/Listeners', 11:49:36 INFO - 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/', 11:49:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:49:36 INFO - 'USER': 'cltbld', 11:49:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:49:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:49:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:36 INFO - 'XPC_FLAGS': '0x0', 11:49:36 INFO - 'XPC_SERVICE_NAME': '0', 11:49:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:49:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:49:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:49:36 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-Qjd0uF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:49:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:49:36 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-GqbA7X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:49:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:49:36 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-uStetz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:49:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:49:36 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-cqfjvZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:49:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:49:36 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-0v0Czh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:49:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:49:37 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-fsMs1h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:49:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:49:37 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-eFzOZv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:49:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:49:37 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-YlsXzc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:49:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:49:37 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-rpLR38-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:49:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:49:37 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-nOTLce-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:49:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:49:37 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-7dkf4s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:49:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:49:37 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-r_dYCR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:49:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:49:37 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-C45hxT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:49:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:49:37 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-QzxgSf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:49:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:49:37 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-OQ4vlT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:49:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:49:38 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-FrImlL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:49:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:49:38 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-5SOoxW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:49:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:49:38 INFO - Running setup.py install for manifestparser 11:49:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:49:38 INFO - Running setup.py install for mozcrash 11:49:38 INFO - Running setup.py install for mozdebug 11:49:38 INFO - Running setup.py install for mozdevice 11:49:38 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:49:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:49:38 INFO - Running setup.py install for mozfile 11:49:39 INFO - Running setup.py install for mozhttpd 11:49:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:49:39 INFO - Running setup.py install for mozinfo 11:49:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:49:39 INFO - Running setup.py install for mozInstall 11:49:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:49:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:49:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:49:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:49:39 INFO - Running setup.py install for mozleak 11:49:39 INFO - Running setup.py install for mozlog 11:49:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:49:39 INFO - Running setup.py install for moznetwork 11:49:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:49:39 INFO - Running setup.py install for mozprocess 11:49:40 INFO - Running setup.py install for mozprofile 11:49:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:49:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:49:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:49:40 INFO - Running setup.py install for mozrunner 11:49:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:49:40 INFO - Running setup.py install for mozscreenshot 11:49:40 INFO - Running setup.py install for moztest 11:49:40 INFO - Running setup.py install for mozversion 11:49:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:49:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:49:40 INFO - Cleaning up... 11:49:40 INFO - Return code: 0 11:49:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:49:40 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')]} 11:49:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:49:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:40 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')]} 11:49:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:49:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:40 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 0x10613da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10614d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9af3cb7f60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105fdce00>, '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 0x105e45db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105fd7b20>, '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.XoXgwXe5Id/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.kgf8dWzmOp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/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 11:49:40 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 11:49:40 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 11:49:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XoXgwXe5Id/Render', 11:49:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:49:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:49:40 INFO - 'HOME': '/Users/cltbld', 11:49:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:49:40 INFO - 'LOGNAME': 'cltbld', 11:49:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:40 INFO - 'MOZ_NO_REMOTE': '1', 11:49:40 INFO - 'NO_EM_RESTART': '1', 11:49:40 INFO - 'PAGER': '/bin/cat', 11:49:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:49:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:40 INFO - 'PWD': '/builds/slave/test', 11:49:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:49:40 INFO - 'SHELL': '/bin/bash', 11:49:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kgf8dWzmOp/Listeners', 11:49:40 INFO - 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/', 11:49:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:49:40 INFO - 'USER': 'cltbld', 11:49:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:49:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:49:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:40 INFO - 'XPC_FLAGS': '0x0', 11:49:40 INFO - 'XPC_SERVICE_NAME': '0', 11:49:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:49:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:49:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:49:41 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-oBCJU4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:49:41 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)) 11:49:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:49:41 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-hEh6zF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:49:41 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)) 11:49:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:49:41 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-3akRT6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:49:41 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)) 11:49:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:49:41 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-GMFDlc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:49:41 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)) 11:49:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:49:41 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-43tCsE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:49:41 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)) 11:49:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:49:41 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-5wXy2z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:49:41 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)) 11:49:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:49:41 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-7xFCGK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:49:41 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)) 11:49:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:49:41 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-_Jdo4R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:49:42 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)) 11:49:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:49:42 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-Osc1Hn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:49:42 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)) 11:49:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:49:42 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-sRwVuZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:49:42 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)) 11:49:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:49:42 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-EeK3mf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:49:42 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)) 11:49:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:49:42 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-HoDNQl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:49:42 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)) 11:49:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:49:42 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-d_re2v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:49:42 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)) 11:49:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:49:42 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-pOucxO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:49:42 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)) 11:49:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:49:42 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-7GJTRd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:49:42 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)) 11:49:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:49:42 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-gouadi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:49:42 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)) 11:49:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:49:42 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-d_EHvw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:49:42 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)) 11:49:42 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)) 11:49:42 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)) 11:49:42 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)) 11:49:42 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)) 11:49:42 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)) 11:49:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:49:43 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 11:49:43 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 11:49:43 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 11:49:43 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 11:49:43 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 11:49:43 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 11:49:45 INFO - Downloading blessings-1.6.tar.gz 11:49:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:49:45 INFO - Installing collected packages: blessings 11:49:45 INFO - Running setup.py install for blessings 11:49:45 INFO - Successfully installed blessings 11:49:45 INFO - Cleaning up... 11:49:45 INFO - Return code: 0 11:49:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:49:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:49:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:49:46 INFO - Reading from file tmpfile_stdout 11:49:46 INFO - Current package versions: 11:49:46 INFO - blessings == 1.6 11:49:46 INFO - blobuploader == 1.2.4 11:49:46 INFO - docopt == 0.6.1 11:49:46 INFO - manifestparser == 1.1 11:49:46 INFO - mozInstall == 1.12 11:49:46 INFO - mozcrash == 0.17 11:49:46 INFO - mozdebug == 0.1 11:49:46 INFO - mozdevice == 0.48 11:49:46 INFO - mozfile == 1.2 11:49:46 INFO - mozhttpd == 0.7 11:49:46 INFO - mozinfo == 0.9 11:49:46 INFO - mozleak == 0.1 11:49:46 INFO - mozlog == 3.1 11:49:46 INFO - moznetwork == 0.27 11:49:46 INFO - mozprocess == 0.22 11:49:46 INFO - mozprofile == 0.28 11:49:46 INFO - mozrunner == 6.11 11:49:46 INFO - mozscreenshot == 0.1 11:49:46 INFO - mozsystemmonitor == 0.0 11:49:46 INFO - moztest == 0.7 11:49:46 INFO - mozversion == 1.4 11:49:46 INFO - psutil == 3.1.1 11:49:46 INFO - requests == 1.2.3 11:49:46 INFO - wsgiref == 0.1.2 11:49:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:49:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:49:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:49:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:49:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:49:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:46 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 0x10613da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10614d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9af3cb7f60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105fdce00>, '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 0x105e45db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105fd7b20>, '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.XoXgwXe5Id/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.kgf8dWzmOp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/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 11:49:46 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 11:49:46 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 11:49:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XoXgwXe5Id/Render', 11:49:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:49:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:49:46 INFO - 'HOME': '/Users/cltbld', 11:49:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:49:46 INFO - 'LOGNAME': 'cltbld', 11:49:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:46 INFO - 'MOZ_NO_REMOTE': '1', 11:49:46 INFO - 'NO_EM_RESTART': '1', 11:49:46 INFO - 'PAGER': '/bin/cat', 11:49:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:49:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:46 INFO - 'PWD': '/builds/slave/test', 11:49:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:49:46 INFO - 'SHELL': '/bin/bash', 11:49:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kgf8dWzmOp/Listeners', 11:49:46 INFO - 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/', 11:49:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:49:46 INFO - 'USER': 'cltbld', 11:49:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:49:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:49:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:46 INFO - 'XPC_FLAGS': '0x0', 11:49:46 INFO - 'XPC_SERVICE_NAME': '0', 11:49:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:49:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:49:46 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)) 11:49:46 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)) 11:49:46 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)) 11:49:46 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)) 11:49:46 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)) 11:49:46 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)) 11:49:46 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)) 11:49:46 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)) 11:49:46 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)) 11:49:46 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)) 11:49:46 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)) 11:49:46 INFO - Cleaning up... 11:49:46 INFO - Return code: 0 11:49:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:49:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:49:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:49:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:49:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:49:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:46 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 0x10613da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10614d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9af3cb7f60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105fdce00>, '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 0x105e45db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105fd7b20>, '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.XoXgwXe5Id/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.kgf8dWzmOp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/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 11:49:46 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 11:49:46 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 11:49:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XoXgwXe5Id/Render', 11:49:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:49:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:49:46 INFO - 'HOME': '/Users/cltbld', 11:49:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:49:46 INFO - 'LOGNAME': 'cltbld', 11:49:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:46 INFO - 'MOZ_NO_REMOTE': '1', 11:49:46 INFO - 'NO_EM_RESTART': '1', 11:49:46 INFO - 'PAGER': '/bin/cat', 11:49:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:49:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:46 INFO - 'PWD': '/builds/slave/test', 11:49:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:49:46 INFO - 'SHELL': '/bin/bash', 11:49:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kgf8dWzmOp/Listeners', 11:49:46 INFO - 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/', 11:49:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:49:46 INFO - 'USER': 'cltbld', 11:49:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:49:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:49:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:46 INFO - 'XPC_FLAGS': '0x0', 11:49:46 INFO - 'XPC_SERVICE_NAME': '0', 11:49:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:49:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:49:46 INFO - Downloading/unpacking jsonschema 11:49:46 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 11:49:46 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 11:49:46 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 11:49:46 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 11:49:46 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 11:49:46 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 11:49:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:49:49 INFO - Downloading/unpacking functools32 (from jsonschema) 11:49:49 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 11:49:49 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 11:49:49 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 11:49:49 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 11:49:49 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 11:49:49 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 11:49:49 INFO - Downloading functools32-3.2.3-2.tar.gz 11:49:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:49:49 INFO - warning: no files found matching '*.txt' 11:49:49 INFO - no previously-included directories found matching 'build' 11:49:49 INFO - no previously-included directories found matching 'dist' 11:49:49 INFO - no previously-included directories found matching '.git*' 11:49:49 INFO - Installing collected packages: jsonschema, functools32 11:49:49 INFO - Running setup.py install for functools32 11:49:49 INFO - warning: no files found matching '*.txt' 11:49:49 INFO - no previously-included directories found matching 'build' 11:49:49 INFO - no previously-included directories found matching 'dist' 11:49:49 INFO - no previously-included directories found matching '.git*' 11:49:49 INFO - Successfully installed jsonschema functools32 11:49:49 INFO - Cleaning up... 11:49:49 INFO - Return code: 0 11:49:49 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:49:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:49:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:49:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:49:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:49:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:49 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 0x10613da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10614d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9af3cb7f60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105fdce00>, '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 0x105e45db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105fd7b20>, '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.XoXgwXe5Id/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.kgf8dWzmOp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/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 11:49:49 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 11:49:49 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 11:49:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XoXgwXe5Id/Render', 11:49:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:49:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:49:49 INFO - 'HOME': '/Users/cltbld', 11:49:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:49:49 INFO - 'LOGNAME': 'cltbld', 11:49:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:49 INFO - 'MOZ_NO_REMOTE': '1', 11:49:49 INFO - 'NO_EM_RESTART': '1', 11:49:49 INFO - 'PAGER': '/bin/cat', 11:49:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:49:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:49 INFO - 'PWD': '/builds/slave/test', 11:49:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:49:49 INFO - 'SHELL': '/bin/bash', 11:49:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kgf8dWzmOp/Listeners', 11:49:49 INFO - 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/', 11:49:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:49:49 INFO - 'USER': 'cltbld', 11:49:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:49:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:49:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:49 INFO - 'XPC_FLAGS': '0x0', 11:49:49 INFO - 'XPC_SERVICE_NAME': '0', 11:49:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:49:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:49:50 INFO - Downloading/unpacking flake8 11:49:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:49:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:49:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:49:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:49:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:49:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:49:52 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:49:52 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:49: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 11:49: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 11:49: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 11:49: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 11:49: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 11:49: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 11:49:52 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:49:52 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:49: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 11:49: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 11:49: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 11:49: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 11:49: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 11:49: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 11:49:53 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:49:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:49:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:49:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:49:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:49:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:49:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:49:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:49:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:49:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:49:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:49:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:49:53 INFO - no previously-included directories found matching 'docs/_build' 11:49:53 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:49:53 INFO - Running setup.py install for pep8 11:49:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:49:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:49:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:49:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:49:54 INFO - no previously-included directories found matching 'docs/_build' 11:49:54 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:49:54 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:49:54 INFO - Cleaning up... 11:49:54 INFO - Return code: 0 11:49:54 INFO - Running post-action listener: _resource_record_post_action 11:49:54 INFO - Running post-action listener: _start_resource_monitoring 11:49:54 INFO - Starting resource monitoring. 11:49:54 INFO - ##### 11:49:54 INFO - ##### Running install step. 11:49:54 INFO - ##### 11:49:54 INFO - Running pre-action listener: _resource_record_pre_action 11:49:54 INFO - Running main action method: install 11:49:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:49:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:49:54 INFO - Reading from file tmpfile_stdout 11:49:54 INFO - Detecting whether we're running mozinstall >=1.0... 11:49:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:49:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:49:54 INFO - Reading from file tmpfile_stdout 11:49:54 INFO - Output received: 11:49:54 INFO - Usage: mozinstall [options] installer 11:49:54 INFO - Options: 11:49:54 INFO - -h, --help show this help message and exit 11:49:54 INFO - -d DEST, --destination=DEST 11:49:54 INFO - Directory to install application into. [default: 11:49:54 INFO - "/builds/slave/test"] 11:49:54 INFO - --app=APP Application being installed. [default: firefox] 11:49:54 INFO - mkdir: /builds/slave/test/build/application 11:49:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 11:49:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.mac.dmg --destination /builds/slave/test/build/application 11:50:16 INFO - Reading from file tmpfile_stdout 11:50:16 INFO - Output received: 11:50:16 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 11:50:16 INFO - Running post-action listener: _resource_record_post_action 11:50:16 INFO - ##### 11:50:16 INFO - ##### Running run-tests step. 11:50:16 INFO - ##### 11:50:16 INFO - Running pre-action listener: _resource_record_pre_action 11:50:16 INFO - Running main action method: run_tests 11:50:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:50:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:50:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:50:16 INFO - 2016-06-27 11:50:16.468 screenresolution[1643:7813] starting screenresolution argv=screenresolution get 11:50:16 INFO - 2016-06-27 11:50:16.471 screenresolution[1643:7813] Display 0: 1600x1200x32@60 11:50:16 INFO - 2016-06-27 11:50:16.477 screenresolution[1644:7815] starting screenresolution argv=screenresolution list 11:50:16 INFO - Available Modes on Display 0 11:50:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:50:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:50:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:50:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:50:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:50:16 INFO - Intel Iris: 11:50:16 INFO - Chipset Model: Intel Iris 11:50:16 INFO - Type: GPU 11:50:16 INFO - Bus: Built-In 11:50:16 INFO - VRAM (Dynamic, Max): 1536 MB 11:50:16 INFO - Vendor: Intel (0x8086) 11:50:16 INFO - Device ID: 0x0a2e 11:50:16 INFO - Revision ID: 0x0009 11:50:16 INFO - Displays: 11:50:16 INFO - Display: 11:50:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:50:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:50:16 INFO - Display Serial Number: 1600x1200 60 11:50:16 INFO - Main Display: Yes 11:50:16 INFO - Mirror: Off 11:50:16 INFO - Online: Yes 11:50:16 INFO - Rotation: Supported 11:50:16 INFO - Return code: 0 11:50:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:50:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:50:16 INFO - Python 2.7.3 11:50:16 INFO - Return code: 0 11:50:16 INFO - grabbing minidump binary from tooltool 11:50:16 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')]} 11:50:16 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 0x105fdce00>, '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 0x105e45db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105fd7b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:50:16 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 11:50:16 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 11:50:16 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:50:16 INFO - Return code: 0 11:50:16 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:50:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:50:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:50:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:50:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:50:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:50:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:50:17 INFO - Return code: 0 11:50:17 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/MzxqhptITsu9WN-TocNehg/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0115', '--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 11:50:17 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/MzxqhptITsu9WN-TocNehg/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0115 --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 11:50:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XoXgwXe5Id/Render', 11:50:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:50:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:50:17 INFO - 'HOME': '/Users/cltbld', 11:50:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:50:17 INFO - 'LOGNAME': 'cltbld', 11:50:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:50:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:50:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:50:17 INFO - 'MOZ_NO_REMOTE': '1', 11:50:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:50:17 INFO - 'NO_EM_RESTART': '1', 11:50:17 INFO - 'PAGER': '/bin/cat', 11:50:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:50:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:50:17 INFO - 'PWD': '/builds/slave/test', 11:50:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:50:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:50:17 INFO - 'SHELL': '/bin/bash', 11:50:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kgf8dWzmOp/Listeners', 11:50:17 INFO - 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/', 11:50:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:50:17 INFO - 'USER': 'cltbld', 11:50:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:50:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:50:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:50:17 INFO - 'XPC_FLAGS': '0x0', 11:50:17 INFO - 'XPC_SERVICE_NAME': '0', 11:50:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:50:17 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/MzxqhptITsu9WN-TocNehg/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0115', '--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 11:50:18 INFO - mozversion application_buildid: 20160627094317 11:50:18 INFO - mozversion application_changeset: 00a6e2ca6e9ab22fe9cbacf4cec52315a8b38b47 11:50:18 INFO - mozversion application_display_name: Firefox 11:50:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:50:18 INFO - mozversion application_name: Firefox 11:50:18 INFO - mozversion application_remotingname: firefox 11:50:18 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 11:50:18 INFO - mozversion application_vendor: Mozilla 11:50:18 INFO - mozversion application_version: 48.0 11:50:18 INFO - mozversion platform_buildid: 20160627094317 11:50:18 INFO - mozversion platform_changeset: 00a6e2ca6e9ab22fe9cbacf4cec52315a8b38b47 11:50:18 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 11:50:18 INFO - mozversion platform_version: 48.0 11:50:18 INFO - using testdate: 1467053418 11:50:18 INFO - actual date: 1467053418 11:50:18 INFO - starting webserver on 'localhost:49275' 11:50:18 INFO - SUITE-START | Running 2 tests 11:50:18 INFO - TEST-START | dromaeo_css 11:50:18 INFO - operating with platform_type : mac_ 11:50:18 INFO - Initialising browser for dromaeo_css test... 11:50:18 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/tmpAlFpIj/profile http://localhost:49275/getInfo.html) 11:50:21 INFO - PROCESS | 1662 | __metrics Screen width/height:1600/1200 11:50:21 INFO - PROCESS | 1662 | colorDepth:24 11:50:21 INFO - PROCESS | 1662 | Browser inner width/height: 1024/689 11:50:21 INFO - PROCESS | 1662 | __metrics 11:50:21 ERROR - PROCESS | 1662 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 11:50:21 INFO - TEST-INFO | 1662: exit 0 11:50:21 INFO - Browser initialized. 11:50:21 INFO - Running cycle 1/1 for dromaeo_css test... 11:50:21 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/tmpAlFpIj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:50:33 INFO - PROCESS | 1667 | RSS: Main: 171343872 11:50:33 INFO - PROCESS | 1667 | 11:51:23 INFO - PROCESS | 1667 | 1467053483327 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] 11:53:33 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49275/tests/dromaeo/cssquery-ext.html) 11:53:34 INFO - PROCESS | 1667 | RSS: Main: 181559296 11:53:34 INFO - PROCESS | 1667 | 11:56:36 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-ext.html (next: http://localhost:49275/tests/dromaeo/cssquery-jquery.html) 11:56:37 INFO - PROCESS | 1667 | RSS: Main: 192585728 11:56:37 INFO - PROCESS | 1667 | 11:59:39 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49275/tests/dromaeo/cssquery-mootools.html) 11:59:39 INFO - PROCESS | 1667 | RSS: Main: 194748416 11:59:39 INFO - PROCESS | 1667 | 12:02:41 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49275/tests/dromaeo/cssquery-prototype.html) 12:02:41 INFO - PROCESS | 1667 | RSS: Main: 198385664 12:02:41 INFO - PROCESS | 1667 | 12:05:44 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49275/tests/dromaeo/cssquery-yui.html) 12:05:44 INFO - PROCESS | 1667 | RSS: Main: 197554176 12:05:44 INFO - PROCESS | 1667 | 12:08:47 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-yui.html (next: http://localhost:49275/tests/dromaeo/cssquery-dojo.html) 12:08:47 INFO - PROCESS | 1667 | RSS: Main: 202432512 12:08:47 INFO - PROCESS | 1667 | 12:08:47 INFO - PROCESS | 1667 | __start_tp_report 12:08:47 INFO - PROCESS | 1667 | _x_x_mozilla_page_load 12:08:47 INFO - PROCESS | 1667 | _x_x_mozilla_page_load_details 12:08:47 INFO - PROCESS | 1667 | |i|pagename|runs| 12:08:47 INFO - PROCESS | 1667 | |0;dojo.html;3624.8550057997677;3653.9269214615724;3677.411614141738;3700.2599480103986;3706.48109264703;5967.970160149204;5969.462748352653;5969.791057312995;6008.609440386383;6017.4885134763545;5946.732397042133;5951.434613711701;5984;6014.428629280223;6025.246844144482;5351.57187425006;5378.838634840941;5388.973055134719;5433.6196466247375;5493.725313734317;5365.7585408656705;5433.049216387136;5471.480209380103;5477.835664930059;5488.341399032121;5423.559398270774;5445.319335083114;5449.455054494559;5478.945210547883;5555.916661250085;5379.946200538003;5483.890322193573;5500.22996780451;5503.752331145108;5514.448555144493;5297.920531192035;5382.165764306539;5392.352917649907;5455.427180146107;5458.754356053987;5564.8330550083565;5700.37295897451;5910.645361278337;5913.586048976574;6006.129111278884;6222.719977601018;6233.906491402633;6240.469560087398;6246.3441338659695;6252.87494250117;6236;6252.3122456529745;6258.06129080637;6276.623402595813;6286.937130628681;5276.841694749125;5863.882722345572;6014.458698717092;6028.909566356509;6090.939090609126;6388.201474815648;6451.096846441502;6476.222853257639;6482.12491313676;6486.513511486657;6240.781572644935;6242.875142497124;6246.46905013079;6255.999040153553;6260.624362538262;5985.910211346833;6262.09199666055;6295.24457065146;6358.586691865014;6360.52296077796;6213.627182369072;6247.094171345129;6249.531285153632;6250.656213908188;6251.062340648939;6145.170401995673;6193.907091393633;6238.251409830758;6266.342034086447;6269.404406581368;4308.504521980012;4986.750662466862;5044.520770526794;5066.138756411419;5102.515261050195;4155.58444155582;4590.196715574828;4603.263477843529;4606.170889239902;4608.677392582487;5855.151003104526;6034.9396506035255;6072.149899014142;6090.269167699905;6099.512039036867;6134.038624681888;6208.9689551551955;6271.3415091414745;6283.905741413882;6312.905306420407;6026.758929642853;6105.450509454082;6112.755489780359;6123.908141377883;6141.84645383869;5500.064988951888;5518.2826232589505;5547.611667183259;5617.747201375948;5626.521745651584;6598;6608.801735947929;6619.0733297339375;6622.569532980341;6632.469402447792;6369.649669268235;6372.203474565679;6379.393957574023;6384.042393640991;6397.808065758035;6362.395572420613;6416.51876109303;6520.804375868732;6570.638614876228;6587.308332625005;6253.843653908507;6255;6290.2766181889665;6291.402316779899;6296.307406185408;6272.529560282906;6312.558120931674;6328.335524769833;6342.524310676626;6378.553501254868;5834.9205397;5850.297964244318;6140.1710769047395;6148.415900489446;6234.0337247726675;6152.723127459186;6205.5345849060595;6218.689065546795;6231.470325022424;6233.781817636361;5152.330197074356;6099.420555047263;6214.9067763984485;6237.594556353823;6255.31191568918;6143.082036032849;6192.318844927145;6220.906686399798;6233.314335423191;6254.906176407449;6141.938580614136;6154.630722156506;6157.107219453064;6166.290876549254;6177.660228687465 12:08:47 INFO - PROCESS | 1667 | |1;ext.html;509.7349378323272;578.7511370110852;583.9970800145999;590.7489317040257;595.3867516458047;37261;39542.406863897064;40109.99999999996;40165;40195.59804401955;42996.92507687309;43703.344449833196;43751;43773.78113109438;43835.90410239746;9791.608335666564;10001.249906257024;10007.199424046059;10023.44871032093;10035.799284014316;9802.558884850163;9820.852687209697;9857.162141217968;9903.900960990406;9921.362975109098;8449.788755281106;9881.604735810559;9889.25830562707;9959.452230127341;9973.850392244121;9891.060349266809;9911.157551608158;9936.602535898555;9946.452945088018;9987.500624968796;9815.067568580973;9862.45756483393;9883.01169883013;9887.80224395508;9950.353227040292;39755.60244397548;39859.60140398617;39904.80285591408;40362.59637403618;40436.191276174606;3217.5978002749657;3373.96626033739;3390.135515443571;3455.3089382123426;3749.2876353492748;25403.364915877068;26985.650717464046;28762.712372876213;29050.33503509899;29431.558526622117;2773.209635253943;2799.2861820235707;2839.0489186122672;2846.117703511918;2883.884644614213;467752;470998;478200;479774;480092.59953700006;37632.62367376346;66122;66557.66721166363;66569;67594;37060.25879482449;37209;37220.627793722255;37246.813765930994;37278.81360593234;13819.378127984264;16429.342826287055;16438.917805410896;17021.91489042547;17040.31838726437;14294.428222870969;14554.636134096732;14579.198144102176;14580.489682861049;14605.92697036508;7332.670029848669;8411.074781774;8528.403011789114;8558.828823423497;8611.870821937677;3275.950860737091;3521.7534772565673;3567.090391950036;3630.673239408466;3641.6540428659237;1045.4197920154236;1045.743792770776;1048.2033654422542;1096.030013438113;1128.3060917535656;23661;30121.548176777367;30464;30575.235619109255;30750.384992300027;1009.9495025248708;1137.2437329176005;1164.2025212729138;1200.9579664711694;1303.88916942061;15596.454124105829;15669;15742.370305187893;15766.817488688393;16043;646864.7656761686;649860;651787;657759;659054;63367.6831615839;63886.36113638897;63903;64094;64151.716965660424;1560.742477491224;1570.9842901571067;1588.269396077794;1596.1221328269637;1606.3173151410838;29500.11499655014;29952.550711738906;30025.5496167562;30714.232144196572;30819.383612328078;55329;55387.44612553823;55634;55748;55775.442245577025;472201;484724;487011;487513;487980;27325.590116147876;28128.85935570309;28515;44303.77848110739;44864.55135448735;44345;44982;45649.54350456453;45742;47122.293165601855;37972.86081417562;38208.617913820504;38438;38630.22739545249;38846.61153388543;37626.43560346542;37951.430728538544;38091.42862857004;38172.04569885664;38857.417138743505;36676.63323366732;36886.63113368832;38021.619783801805;38087.66693165726;38153.236935261695;32557.511637325933;32947.528935330425;33149.50275745914;33454.49818252777;33675;25365;25532.23403297904;25604.23187304384;25834;26280.8685956569 12:08:47 INFO - PROCESS | 1667 | |2;jquery.html;388.24292629372724;415.49102349621717;418.36617524450463;421.4247552091392;430.99138017239653;20968.475788105305;21404;21704.565908681838;21768.564628707416;22396.992135353907;12172;12879.969602431807;18457.35399261026;22137.225197118103;22447.55104897901;5271.367435907697;5388.91916621251;5740.512056475184;6300.716467758962;6310.305866354697;6126.969365153191;6131.47882429994;6135.601185922901;6222.595531290452;6246.25044994599;5902.586818922677;6074.908876366858;6204.379562043805;6216.720247588847;6230.719617617218;6122.051082082285;6137.110119032737;6150.231221097363;6163.167972323724;6180.227471566054;5319.601029922771;5379.085555455543;5454.863628409282;5481.835544933659;5546.91679624806;20042.599148017103;26241.21276361712;26667.33331666724;27069.729302707114;27793.86103069492;2107.8102970732552;2231.665250212481;2465.6917885264343;2546.987265063663;2843.3460304130167;10238.18094552434;10457.267991240617;10467.84298235527;10509.737256568647;10511.73720656982;1830.2404502131599;1851.1762265791729;1859.8698091133626;1876.2026138890917;1932.1981377728225;83288.58355708183;120450.5909881815;123103;125548;128532;10208.336458130347;11925.522979080739;12221.144519883523;12317.630471085882;12412.441440135215;15546.9222653886;15734.842651573566;15850.603734906488;15996.76004859928;16052.117133557533;9559.952200238955;9609.423434593808;9626.65226868239;9704.757381065388;9757.219422446187;9697.709068727949;9765.462899540593;9789.853152202722;9794.432890737591;9851.802963940681;4924.4090709115135;4932.7533623319405;4956.281339205795;4969.801207951641;4976.154053810788;2058.639738045836;2127.978720212809;2131.8294536437047;2135.839812014105;2170.7178066851206;903.503073309677;1001.3741411617739;1042.7080417483116;1071.7320669832543;1096.2271598523023;21176.89411552963;21268.468288292606;21434.57130857374;21720.674189887166;21756;972.3193764364972;997.486294558303;1015.4262841494532;1048.8741351037772;1073.1200415659084;11196.608118715805;11516.539338426537;11551;11565.884341156481;11608.825867611993;633535;636730;646047;648513;649617;79411;133919;138719.61280387067;139198;139637.6036239645;1059.1156384419096;1117.502711293483;1133.3369978562469;1136.108155098244;1137.0448822988728;18622.53443663919;18671.41292990111;19231.711524327427;19289.035548222815;19487.512812179808;39404;56852;57252.713736431055;57360.71319643375;61206.77586448335;81123.59438203007;84641.73037404321;85087;85763.71354429564;86235.56882215549;8462.619182136696;8510.531920744419;8591.140885911358;8672.479651220947;8712.91287087121;9408.858867117136;12381.257124572554;13067.542636007694;13232.470701171846;13266.403011864297;10955.616553420592;11374.772504550028;11403.600873969703;11427.971482566609;11592.072634189077;11061.11511079128;11236.213465057368;11350.318980860844;11490.540378385105;11582.073434125417;11582.594609188638;11649.825252621387;11697.06423486136;11776.11679124052;11812;8035.718749843727;8430.550628768873;8434.283085937765;8707.564621768759;8830.955845220733;8460.788480287796;10619.256652034592;11686.824697629712;11697.2981621103;11780.352080635646 12:08:47 INFO - PROCESS | 1667 | |3;mootools.html;1455.345094707382;1595.1306537936823;1617.7007253658073;1974.8025197480263;2016.1229865008713;8358.874616880752;9034.548272586377;9116.544172791359;9361;9361.48511831849;9048.230900373459;9055.094490550942;9212.986571477131;9252.768680782967;9265.30510211735;2127.585120901425;2523.8485690858515;2527.431327951215;2533.607290869918;2553.2978430931457;2260.525289689167;2389.991414690309;2562.1160699558623;2585.9612105818333;2586.8706564671784;2537.4671319023028;2556.1181392419585;2564.8589327586974;2565.9230223093336;2567.9101231456902;2528.1783420388356;2534.6451496790464;2568.935776605581;2571.5628343181515;2572.3826281692445;2540.4538024324675;2558.5650439425344;2569.203546900467;2575.2016874768883;2596.0135148643585;9312.301577381655;9347.859782103274;9349.953250233706;9363.812723745556;9368.016358282419;4871.756412179377;5678.829635110953;5704.458076482728;5822.155787410802;5863.179154918314;3648.9270214595826;3747.756395834262;3753.6246375362516;3762.698984081267;3831.3103641344546;1053.8682664666917;1068.5298468673836;1089.1395797320108;1089.9509522071526;1094.8029354716148;12409.317487538181;12445.62663120108;12520.624381268577;12550.372481375985;12585.74828503434;5070.670406423571;5119.795208191705;5155.716435596079;5157.793688252503;5233.188855727369;10566.682999510027;10623.681289561326;10668.733281667865;10675.57297708083;10732.980366865135;5799.536037117021;5818.330891947396;5844.620099693507;5848.385919478478;5880;4645.72125672454;5053.9494605054215;5141;5169.974150129226;5234.816781412708;4273.9358909616385;4290.206311832321;4355.869323920288;4363.912721745611;4366.825326986885;1406.296851574213;1424.173979092124;1430.7710766277346;1435.842057373688;1440.337444775394;946.668665966906;947.3842002698301;967.8693376394237;971.5336638413601;978.5498670611598;6009.489193418608;6072.605280656743;6103.6032657877095;6153.600015998945;6207.937920620826;466.4985140973467;476.71158948835455;481.52569718826925;1062.824633935392;1064.090202876545;4010.7593544387432;4086.387041943732;4097.631213190767;4111.794410279534;4132.938005929914;10871.402072886067;11472.024877885473;11563.537458501734;11566.595169169039;11607.187496875307;10925.562977480811;11243.156763242627;11334.206605537698;11370.772584548262;11395.031422329195;8758.343124265706;8817.867731984026;8887.244584210286;8907.331950103639;8933.15135062168;5766.94233057664;5941.287045554561;5996.640201587918;5997.940020599913;6021.789237376671;10015.949920250643;10058;10138.645147419806;10154.746131346776;10284;10121.746956325856;10530.210234232616;10540.736481588021;10551.736206594896;10744.570217191225;6618.801435956929;7242.203357630762;7305.5981920994855;7399.223081576357;7492.438067145095;8479.109693482342;8606.311495080503;8651.394402391772;8652.610632521426;8707.695230666895;6563.9343606563325;7646.388288936983;7692.269234422721;7764.92235077642;7868.213178682086;7547.28300811422;7551.244875512405;7581.355584775356;7641.35048520882;7711.845763084595;6291;7145.1425828900865;7236.34872861445;7236.746713864989;7242.275772422716;4964.851054468371;4989.575886049726;5052.823151189691;5161.896762064663;5168.870778230575;5119.334486516729;5120.871978200575;5224.791008359623;5342.98483288174;5352.839414817562 12:08:47 INFO - PROCESS | 1667 | |4;prototype.html;333.0159379034951;336.59440374348895;337.71800546543636;343.010414952861;346.79712368264563;6955.686994085266;6981.1622605287375;6998.370146686797;6999.020137180799;7017.6140312282805;6822.761203357871;6862.176538815336;6885.345892140252;6913.308669133085;6915.757948471804;4073.490813648294;4872.731999740022;4948.183549714293;5076.974615126937;5095.898082038357;5015.3730783652045;5076.416212135615;5077.187649976005;5095.955329157532;5096.770645320969;5017.774200160983;5032.396112466509;5034.82378116766;5052.772625231855;5055.3933527976515;5025.84922452327;5049.772760225798;5062.190049592066;5076.695398276115;5085.516875896784;3550.786952782841;3557.2707594942976;4359.738415695068;4370.497392799805;4374.387585737999;6444.291127975919;6606.966965165191;6661.134052573135;6672.7330906764155;6687.465002799764;5970.6716130612795;6009.248843894513;6011.30869949957;6014.2181516403025;6035.253959448441;7406.666699998513;7435.8141046474275;7436.888446673304;7445.329920307198;7465.664045117983;4906.994066216417;4932.630052746023;4935.136351138536;4948.307236986825;4954.975225123887;7710.587052732767;7789.493682910593;7888.171741967069;7903.960480197619;7915.406344524184;4056.9797151014645;4161;5007.774650140753;5010.649254552146;5038.748062596856;4181.560936101726;4576.4737055239075;4763.356946812205;5085.211792172219;5130.076586214443;5945.821625351246;5987.491063259585;5989.161517387569;6000.639961602318;6014.368491308437;7486.326230639269;7497.812554686067;7500.737474188377;7508.3993280537425;7509.061367329084;1655.7019736447555;1781.100544225184;1802.3691707902392;1808.0236672196866;1810.4025671528364;1070.2829104500004;1086.6794295682791;1095.906847917936;1097.155190503308;1098.774751176023;6958.443324534025;7038.436925045984;7046.6476676165985;7062;7087.92912070883;6304.401081897213;7583.924160758432;7776.783616669222;7790.805229869298;7799.805004874924;6947.965260173768;7055.0475685782785;7066.611336376549;7068.974998625171;7116.110486189226;4101.89745256365;4211.326187809997;4256.787160641956;4267.338562522752;4275.4441922550495;6665.833354166088;8310.83378332442;8316.625751841182;8320.958395208107;8326.916730832736;6350.618962862243;8192.722910835713;8204.097549269694;8234.670613175405;8239.835203296021;8271.503709777433;8296.709615163561;8299.875501867476;8333.958330208432;8358.289545388589;7910.802229944297;7920;7932.444728868923;7955.164707705608;7993.960030199812;7762.961185194038;7763.844723105393;7764.611769411394;7778.649960751893;7780.572068536058;7978.601069946596;8252.133525979925;8290.502569845587;8307.875381869157;8365.623546940524;4870.1964175912;4875.609951203966;4927.975360123177;4929.16204245272;4933.6299777516115;5629.831105066854;6509.902351464826;7855.5286682799215;7861.842763144591;7871.645775939982;6156.768646270674;7537.510061845963;7589.848203036019;7595.08858936909;7609.505382150142;6998.930010699828;7517.173110957681;7542.2834830691;7543.698252070075;7556.433267504849;6073.5748497604745;7233.927660723325;7395.519291246052;7406.925930740624;7415.740449084472;5810.01229790945;7377.372923301579;7557.395408367208;7568.091828980558;7735.6905723770415;7179.748708795376;7370.078740157481;7376.225496322809;7377.5204611700065;7408.62956852166 12:08:47 INFO - PROCESS | 1667 | |5;yui.html;683.0846665468272;724.8622761675282;758.3099379564594;777.8016605765528;778.1829079466562;15380.923095384522;15549.611259718513;15615.375384984616;15664.373425062984;15716.685666286667;14376.856231437683;14385.496507622236;14402.567922962327;14408.855911440882;14410.919181061436;758.2758465665277;899.8965119011316;915.244922938575;917.2295271971576;925.708401853414;890.5458216309664;907.3467103685336;922.3635691372965;925.8102089071724;948.9762755931088;927.420362273579;934.2759361494828;964.4068897627978;969.0116081596802;992.136840948376;926.36081104038;927.4713413354391;962.6630679262272;966.6713317472058;993.006993006993;647.0843756085134;724.2467833453202;752.9435292353096;753.8228516298666;758.1281526244808;15141.167235802026;15172.696546069128;15172.772408413883;15196.316165772456;15341.079535227811;12956.870431295662;12970.092093553456;13152.210867347894;13216.140950838164;13218.07473476857;10166.339187952759;10261.127804136582;10351.430671313075;10379.42913139777;10419.635312764018;3567.661072198163;3601.1537288737127;3614.0964758810296;3638.6543278388513;3810.428435734634;83957.7224819719;87474.12525874724;87945.68081478847;88279.35161945153;89164.5541772287;9409.717708468757;9546.140847323635;9627.374220675634;9679.274054445945;9975;21926.780732192794;22624.773752262266;22632.207872724375;22684.319470415914;22711.88644056769;7732.226777322336;7831.608419578998;7873.606319683993;7913.248241417056;7990.960045199853;4141.026858688206;4188.748675079505;4204.180184863983;4211.157768446323;4234.640055595247;3638.4542318652416;3752.1932784451474;3804.1630841214887;3811.294910441577;3896.6687831534637;698.0332239847847;704.7181127549021;715.3347386930205;721.8195451137216;722.0937723157404;568.7525926222024;574.5461085742216;582.7290310005868;594.4382558482192;595.787572290387;7716.48358226822;8115.188481151838;8294.709685160991;8296.83406331882;8385.6226469809;470.3109943932156;509.806273616031;566.6005466146357;571.5056476148102;587.5769445998959;3769.3403654360377;3872.9225415491533;3897.9220415592094;3947.388154836005;4054.574269701639;87720;87737;88207.55896220607;90112.6483102754;90528;57534;79797.60101199457;79949;80983.59508202421;81619.7757033645;68308.6584567074;69462.61074778475;69808.6509567449;70209.89370318898;70856.93714594285;7742;7873.842523149619;8567.571621419029;8635.870461943201;8728.912710873064;43563.78218108889;46325.76837115793;50444;50866.74566627143;50917.727056823875;50823.745881270355;66873.66563167152;70990.64504677443;73373.53252935018;74418.62790686011;9280.814383712153;10896;11237.213395062266;11304.152188585724;11475.368854713071;12098.516059357527;12217.266963982189;12264.877351226374;12423.317458265936;12637.810432843698;11416;11572.074234061087;11642.88357116418;11681.415929203336;11720;11690.47392867306;11805.82291265649;11877.346745929057;12006.039516838806;12231.327276999851;11477.36874471912;11640.126990475579;11766.117541184274;11857.40712964331;11968.521259149536;9952.402855828674;9979.151772099163;10082.143017843566;10125.949370253102;10379.636712715019;9900.356476828983;10096;10119.595216191565;10121;10177.287589868934 12:08:47 INFO - PROCESS | 1667 | __end_tp_report 12:08:47 INFO - PROCESS | 1667 | __start_cc_report 12:08:47 INFO - PROCESS | 1667 | _x_x_mozilla_cycle_collect,396 12:08:47 INFO - PROCESS | 1667 | __end_cc_report 12:08:47 INFO - PROCESS | 1667 | __startTimestamp1467054527332__endTimestamp 12:08:47 INFO - PROCESS | 1667 | 12:08:47 INFO - PROCESS | 1667 | ------- Summary: start ------- 12:08:47 INFO - PROCESS | 1667 | Number of tests: 6 12:08:47 INFO - PROCESS | 1667 | 12:08:47 INFO - PROCESS | 1667 | [#0] dojo.html Cycles:165 Average:5893.88 Median:6141.94 stddev:617.20 (10.0%) stddev-sans-first:592.86 12:08:47 INFO - PROCESS | 1667 | Values: 3624.9 3653.9 3677.4 3700.3 3706.5 5968.0 5969.5 5969.8 6008.6 6017.5 5946.7 5951.4 5984.0 6014.4 6025.2 5351.6 5378.8 5389.0 5433.6 5493.7 5365.8 5433.0 5471.5 5477.8 5488.3 5423.6 5445.3 5449.5 5478.9 5555.9 5379.9 5483.9 5500.2 5503.8 5514.4 5297.9 5382.2 5392.4 5455.4 5458.8 5564.8 5700.4 5910.6 5913.6 6006.1 6222.7 6233.9 6240.5 6246.3 6252.9 6236.0 6252.3 6258.1 6276.6 6286.9 5276.8 5863.9 6014.5 6028.9 6090.9 6388.2 6451.1 6476.2 6482.1 6486.5 6240.8 6242.9 6246.5 6256.0 6260.6 5985.9 6262.1 6295.2 6358.6 6360.5 6213.6 6247.1 6249.5 6250.7 6251.1 6145.2 6193.9 6238.3 6266.3 6269.4 4308.5 4986.8 5044.5 5066.1 5102.5 4155.6 4590.2 4603.3 4606.2 4608.7 5855.2 6034.9 6072.1 6090.3 6099.5 6134.0 6209.0 6271.3 6283.9 6312.9 6026.8 6105.5 6112.8 6123.9 6141.8 5500.1 5518.3 5547.6 5617.7 5626.5 6598.0 6608.8 6619.1 6622.6 6632.5 6369.6 6372.2 6379.4 6384.0 6397.8 6362.4 6416.5 6520.8 6570.6 6587.3 6253.8 6255.0 6290.3 6291.4 6296.3 6272.5 6312.6 6328.3 6342.5 6378.6 5834.9 5850.3 6140.2 6148.4 6234.0 6152.7 6205.5 6218.7 6231.5 6233.8 5152.3 6099.4 6214.9 6237.6 6255.3 6143.1 6192.3 6220.9 6233.3 6254.9 6141.9 6154.6 6157.1 6166.3 6177.7 12:08:47 INFO - PROCESS | 1667 | 12:08:47 INFO - PROCESS | 1667 | [#1] ext.html Cycles:180 Average:66989.73 Median:38089.55 stddev:145309.40 (381.5%) stddev-sans-first:145631.30 12:08:47 INFO - PROCESS | 1667 | Values: 509.7 578.8 584.0 590.7 595.4 37261.0 39542.4 40110.0 40165.0 40195.6 42996.9 43703.3 43751.0 43773.8 43835.9 9791.6 10001.2 10007.2 10023.4 10035.8 9802.6 9820.9 9857.2 9903.9 9921.4 8449.8 9881.6 9889.3 9959.5 9973.9 9891.1 9911.2 9936.6 9946.5 9987.5 9815.1 9862.5 9883.0 9887.8 9950.4 39755.6 39859.6 39904.8 40362.6 40436.2 3217.6 3374.0 3390.1 3455.3 3749.3 25403.4 26985.7 28762.7 29050.3 29431.6 2773.2 2799.3 2839.0 2846.1 2883.9 467752.0 470998.0 478200.0 479774.0 480092.6 37632.6 66122.0 66557.7 66569.0 67594.0 37060.3 37209.0 37220.6 37246.8 37278.8 13819.4 16429.3 16438.9 17021.9 17040.3 14294.4 14554.6 14579.2 14580.5 14605.9 7332.7 8411.1 8528.4 8558.8 8611.9 3276.0 3521.8 3567.1 3630.7 3641.7 1045.4 1045.7 1048.2 1096.0 1128.3 23661.0 30121.5 30464.0 30575.2 30750.4 1009.9 1137.2 1164.2 1201.0 1303.9 15596.5 15669.0 15742.4 15766.8 16043.0 646864.8 649860.0 651787.0 657759.0 659054.0 63367.7 63886.4 63903.0 64094.0 64151.7 1560.7 1571.0 1588.3 1596.1 1606.3 29500.1 29952.6 30025.5 30714.2 30819.4 55329.0 55387.4 55634.0 55748.0 55775.4 472201.0 484724.0 487011.0 487513.0 487980.0 27325.6 28128.9 28515.0 44303.8 44864.6 44345.0 44982.0 45649.5 45742.0 47122.3 37972.9 38208.6 38438.0 38630.2 38846.6 37626.4 37951.4 38091.4 38172.0 38857.4 36676.6 36886.6 38021.6 38087.7 38153.2 32557.5 32947.5 33149.5 33454.5 33675.0 25365.0 25532.2 25604.2 25834.0 26280.9 12:08:47 INFO - PROCESS | 1667 | 12:08:47 INFO - PROCESS | 1667 | [#2] jquery.html Cycles:180 Average:36607.03 Median:21762.28 stddev:106972.76 (491.6%) stddev-sans-first:107238.27 12:08:47 INFO - PROCESS | 1667 | Values: 388.2 415.5 418.4 421.4 431.0 20968.5 21404.0 21704.6 21768.6 22397.0 12172.0 12880.0 18457.4 22137.2 22447.6 5271.4 5388.9 5740.5 6300.7 6310.3 6127.0 6131.5 6135.6 6222.6 6246.3 5902.6 6074.9 6204.4 6216.7 6230.7 6122.1 6137.1 6150.2 6163.2 6180.2 5319.6 5379.1 5454.9 5481.8 5546.9 20042.6 26241.2 26667.3 27069.7 27793.9 2107.8 2231.7 2465.7 2547.0 2843.3 10238.2 10457.3 10467.8 10509.7 10511.7 1830.2 1851.2 1859.9 1876.2 1932.2 83288.6 120450.6 123103.0 125548.0 128532.0 10208.3 11925.5 12221.1 12317.6 12412.4 15546.9 15734.8 15850.6 15996.8 16052.1 9560.0 9609.4 9626.7 9704.8 9757.2 9697.7 9765.5 9789.9 9794.4 9851.8 4924.4 4932.8 4956.3 4969.8 4976.2 2058.6 2128.0 2131.8 2135.8 2170.7 903.5 1001.4 1042.7 1071.7 1096.2 21176.9 21268.5 21434.6 21720.7 21756.0 972.3 997.5 1015.4 1048.9 1073.1 11196.6 11516.5 11551.0 11565.9 11608.8 633535.0 636730.0 646047.0 648513.0 649617.0 79411.0 133919.0 138719.6 139198.0 139637.6 1059.1 1117.5 1133.3 1136.1 1137.0 18622.5 18671.4 19231.7 19289.0 19487.5 39404.0 56852.0 57252.7 57360.7 61206.8 81123.6 84641.7 85087.0 85763.7 86235.6 8462.6 8510.5 8591.1 8672.5 8712.9 9408.9 12381.3 13067.5 13232.5 13266.4 10955.6 11374.8 11403.6 11428.0 11592.1 11061.1 11236.2 11350.3 11490.5 11582.1 11582.6 11649.8 11697.1 11776.1 11812.0 8035.7 8430.6 8434.3 8707.6 8831.0 8460.8 10619.3 11686.8 11697.3 11780.4 12:08:47 INFO - PROCESS | 1667 | 12:08:47 INFO - PROCESS | 1667 | [#3] mootools.html Cycles:180 Average:5986.62 Median:2676.64 stddev:3360.45 (125.5%) stddev-sans-first:3352.62 12:08:47 INFO - PROCESS | 1667 | Values: 1455.3 1595.1 1617.7 1974.8 2016.1 8358.9 9034.5 9116.5 9361.0 9361.5 9048.2 9055.1 9213.0 9252.8 9265.3 2127.6 2523.8 2527.4 2533.6 2553.3 2260.5 2390.0 2562.1 2586.0 2586.9 2537.5 2556.1 2564.9 2565.9 2567.9 2528.2 2534.6 2568.9 2571.6 2572.4 2540.5 2558.6 2569.2 2575.2 2596.0 9312.3 9347.9 9350.0 9363.8 9368.0 4871.8 5678.8 5704.5 5822.2 5863.2 3648.9 3747.8 3753.6 3762.7 3831.3 1053.9 1068.5 1089.1 1090.0 1094.8 12409.3 12445.6 12520.6 12550.4 12585.7 5070.7 5119.8 5155.7 5157.8 5233.2 10566.7 10623.7 10668.7 10675.6 10733.0 5799.5 5818.3 5844.6 5848.4 5880.0 4645.7 5053.9 5141.0 5170.0 5234.8 4273.9 4290.2 4355.9 4363.9 4366.8 1406.3 1424.2 1430.8 1435.8 1440.3 946.7 947.4 967.9 971.5 978.5 6009.5 6072.6 6103.6 6153.6 6207.9 466.5 476.7 481.5 1062.8 1064.1 4010.8 4086.4 4097.6 4111.8 4132.9 10871.4 11472.0 11563.5 11566.6 11607.2 10925.6 11243.2 11334.2 11370.8 11395.0 8758.3 8817.9 8887.2 8907.3 8933.2 5766.9 5941.3 5996.6 5997.9 6021.8 10015.9 10058.0 10138.6 10154.7 10284.0 10121.7 10530.2 10540.7 10551.7 10744.6 6618.8 7242.2 7305.6 7399.2 7492.4 8479.1 8606.3 8651.4 8652.6 8707.7 6563.9 7646.4 7692.3 7764.9 7868.2 7547.3 7551.2 7581.4 7641.4 7711.8 6291.0 7145.1 7236.3 7236.7 7242.3 4964.9 4989.6 5052.8 5161.9 5168.9 5119.3 5120.9 5224.8 5343.0 5352.8 12:08:47 INFO - PROCESS | 1667 | 12:08:47 INFO - PROCESS | 1667 | [#4] prototype.html Cycles:180 Average:6086.82 Median:6899.33 stddev:1997.41 (29.0%) stddev-sans-first:1955.77 12:08:47 INFO - PROCESS | 1667 | Values: 333.0 336.6 337.7 343.0 346.8 6955.7 6981.2 6998.4 6999.0 7017.6 6822.8 6862.2 6885.3 6913.3 6915.8 4073.5 4872.7 4948.2 5077.0 5095.9 5015.4 5076.4 5077.2 5096.0 5096.8 5017.8 5032.4 5034.8 5052.8 5055.4 5025.8 5049.8 5062.2 5076.7 5085.5 3550.8 3557.3 4359.7 4370.5 4374.4 6444.3 6607.0 6661.1 6672.7 6687.5 5970.7 6009.2 6011.3 6014.2 6035.3 7406.7 7435.8 7436.9 7445.3 7465.7 4907.0 4932.6 4935.1 4948.3 4955.0 7710.6 7789.5 7888.2 7904.0 7915.4 4057.0 4161.0 5007.8 5010.6 5038.7 4181.6 4576.5 4763.4 5085.2 5130.1 5945.8 5987.5 5989.2 6000.6 6014.4 7486.3 7497.8 7500.7 7508.4 7509.1 1655.7 1781.1 1802.4 1808.0 1810.4 1070.3 1086.7 1095.9 1097.2 1098.8 6958.4 7038.4 7046.6 7062.0 7087.9 6304.4 7583.9 7776.8 7790.8 7799.8 6948.0 7055.0 7066.6 7069.0 7116.1 4101.9 4211.3 4256.8 4267.3 4275.4 6665.8 8310.8 8316.6 8321.0 8326.9 6350.6 8192.7 8204.1 8234.7 8239.8 8271.5 8296.7 8299.9 8334.0 8358.3 7910.8 7920.0 7932.4 7955.2 7994.0 7763.0 7763.8 7764.6 7778.6 7780.6 7978.6 8252.1 8290.5 8307.9 8365.6 4870.2 4875.6 4928.0 4929.2 4933.6 5629.8 6509.9 7855.5 7861.8 7871.6 6156.8 7537.5 7589.8 7595.1 7609.5 6998.9 7517.2 7542.3 7543.7 7556.4 6073.6 7233.9 7395.5 7406.9 7415.7 5810.0 7377.4 7557.4 7568.1 7735.7 7179.7 7370.1 7376.2 7377.5 7408.6 12:08:47 INFO - PROCESS | 1667 | 12:08:47 INFO - PROCESS | 1667 | [#5] yui.html Cycles:180 Average:18442.75 Median:570.13 stddev:25718.11 (4510.9%) stddev-sans-first:25755.69 12:08:47 INFO - PROCESS | 1667 | Values: 683.1 724.9 758.3 777.8 778.2 15380.9 15549.6 15615.4 15664.4 15716.7 14376.9 14385.5 14402.6 14408.9 14410.9 758.3 899.9 915.2 917.2 925.7 890.5 907.3 922.4 925.8 949.0 927.4 934.3 964.4 969.0 992.1 926.4 927.5 962.7 966.7 993.0 647.1 724.2 752.9 753.8 758.1 15141.2 15172.7 15172.8 15196.3 15341.1 12956.9 12970.1 13152.2 13216.1 13218.1 10166.3 10261.1 10351.4 10379.4 10419.6 3567.7 3601.2 3614.1 3638.7 3810.4 83957.7 87474.1 87945.7 88279.4 89164.6 9409.7 9546.1 9627.4 9679.3 9975.0 21926.8 22624.8 22632.2 22684.3 22711.9 7732.2 7831.6 7873.6 7913.2 7991.0 4141.0 4188.7 4204.2 4211.2 4234.6 3638.5 3752.2 3804.2 3811.3 3896.7 698.0 704.7 715.3 721.8 722.1 568.8 574.5 582.7 594.4 595.8 7716.5 8115.2 8294.7 8296.8 8385.6 470.3 509.8 566.6 571.5 587.6 3769.3 3872.9 3897.9 3947.4 4054.6 87720.0 87737.0 88207.6 90112.6 90528.0 57534.0 79797.6 79949.0 80983.6 81619.8 68308.7 69462.6 69808.7 70209.9 70856.9 7742.0 7873.8 8567.6 8635.9 8728.9 43563.8 46325.8 50444.0 50866.7 50917.7 50823.7 66873.7 70990.6 73373.5 74418.6 9280.8 10896.0 11237.2 11304.2 11475.4 12098.5 12217.3 12264.9 12423.3 12637.8 11416.0 11572.1 11642.9 11681.4 11720.0 11690.5 11805.8 11877.3 12006.0 12231.3 11477.4 11640.1 11766.1 11857.4 11968.5 9952.4 9979.2 10082.1 10125.9 10379.6 9900.4 10096.0 10119.6 10121.0 10177.3 12:08:47 INFO - PROCESS | 1667 | -------- Summary: end -------- 12:08:47 INFO - PROCESS | 1667 | 12:08:47 INFO - TEST-INFO | 1667: exit 0 12:08:47 INFO - TEST-OK | dromaeo_css | took 1109699ms 12:08:47 INFO - TEST-START | kraken 12:08:47 INFO - operating with platform_type : mac_ 12:08:47 INFO - Initialising browser for kraken test... 12:08:47 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/tmpagQZNf/profile http://localhost:49275/getInfo.html) 12:08:50 INFO - PROCESS | 1675 | __metrics Screen width/height:1600/1200 12:08:50 INFO - PROCESS | 1675 | colorDepth:24 12:08:50 INFO - PROCESS | 1675 | Browser inner width/height: 1024/689 12:08:50 INFO - PROCESS | 1675 | __metrics 12:08:50 ERROR - PROCESS | 1675 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 12:08:51 INFO - TEST-INFO | 1675: exit 0 12:08:51 INFO - Browser initialized. 12:08:51 INFO - Running cycle 1/1 for kraken test... 12:08:51 INFO - TEST-INFO | started process 1679 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/tmpagQZNf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:09:03 INFO - PROCESS | 1679 | RSS: Main: 171003904 12:09:03 INFO - PROCESS | 1679 | 12:09:05 INFO - PROCESS | 1679 | 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) 12:09:06 INFO - PROCESS | 1679 | RSS: Main: 183558144 12:09:06 INFO - PROCESS | 1679 | 12:09:09 INFO - PROCESS | 1679 | 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) 12:09:09 INFO - PROCESS | 1679 | RSS: Main: 192196608 12:09:09 INFO - PROCESS | 1679 | 12:09:13 INFO - PROCESS | 1679 | 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) 12:09:13 INFO - PROCESS | 1679 | RSS: Main: 195915776 12:09:13 INFO - PROCESS | 1679 | 12:09:15 INFO - PROCESS | 1679 | 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) 12:09:16 INFO - PROCESS | 1679 | RSS: Main: 197115904 12:09:16 INFO - PROCESS | 1679 | 12:09:18 INFO - PROCESS | 1679 | 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) 12:09:19 INFO - PROCESS | 1679 | RSS: Main: 197361664 12:09:19 INFO - PROCESS | 1679 | 12:09:21 INFO - PROCESS | 1679 | 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) 12:09:22 INFO - PROCESS | 1679 | RSS: Main: 197873664 12:09:22 INFO - PROCESS | 1679 | 12:09:25 INFO - PROCESS | 1679 | 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) 12:09:26 INFO - PROCESS | 1679 | RSS: Main: 198152192 12:09:26 INFO - PROCESS | 1679 | 12:09:28 INFO - PROCESS | 1679 | 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) 12:09:29 INFO - PROCESS | 1679 | RSS: Main: 197943296 12:09:29 INFO - PROCESS | 1679 | 12:09:31 INFO - PROCESS | 1679 | 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) 12:09:31 INFO - PROCESS | 1679 | RSS: Main: 197677056 12:09:31 INFO - PROCESS | 1679 | 12:09:33 INFO - PROCESS | 1679 | 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) 12:09:34 INFO - PROCESS | 1679 | RSS: Main: 197840896 12:09:34 INFO - PROCESS | 1679 | 12:09:36 INFO - PROCESS | 1679 | 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) 12:09:37 INFO - PROCESS | 1679 | RSS: Main: 197697536 12:09:37 INFO - PROCESS | 1679 | 12:09:39 INFO - PROCESS | 1679 | 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) 12:09:40 INFO - PROCESS | 1679 | RSS: Main: 197849088 12:09:40 INFO - PROCESS | 1679 | 12:09:43 INFO - PROCESS | 1679 | 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) 12:09:43 INFO - PROCESS | 1679 | RSS: Main: 197795840 12:09:43 INFO - PROCESS | 1679 | 12:09:45 INFO - PROCESS | 1679 | 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) 12:09:45 INFO - PROCESS | 1679 | RSS: Main: 199741440 12:09:45 INFO - PROCESS | 1679 | 12:09:45 INFO - PROCESS | 1679 | __start_tp_report 12:09:45 INFO - PROCESS | 1679 | _x_x_mozilla_page_load 12:09:45 INFO - PROCESS | 1679 | _x_x_mozilla_page_load_details 12:09:45 INFO - PROCESS | 1679 | |i|pagename|runs| 12:09:45 INFO - PROCESS | 1679 | |0;ai-astar;117;106;116;118;117;132;116;116;116;115 12:09:45 INFO - PROCESS | 1679 | |1;audio-beat-detection;156;122;143;161;119;135;176;113;209;155 12:09:45 INFO - PROCESS | 1679 | |2;audio-dft;259;251;198;201;196;196;196;198;198;198 12:09:45 INFO - PROCESS | 1679 | |3;audio-fft;66;78;73;145;56;57;57;67;159;46 12:09:45 INFO - PROCESS | 1679 | |4;audio-oscillator;80;81;134;114;116;118;120;77;78;117 12:09:45 INFO - PROCESS | 1679 | |5;imaging-gaussian-blur;92;89;92;88;91;87;92;89;92;88 12:09:45 INFO - PROCESS | 1679 | |6;imaging-darkroom;132;107;152;153;115;97;98;97;96;97 12:09:45 INFO - PROCESS | 1679 | |7;imaging-desaturate;90;92;91;90;90;91;116;119;91;103 12:09:45 INFO - PROCESS | 1679 | |8;json-parse-financial;58;65;62;66;89;98;90;78;63;60 12:09:45 INFO - PROCESS | 1679 | |9;json-stringify-tinderbox;62;63;70;67;69;70;71;95;65;66 12:09:45 INFO - PROCESS | 1679 | |10;stanford-crypto-aes;81;83;83;82;80;79;81;81;85;83 12:09:45 INFO - PROCESS | 1679 | |11;stanford-crypto-ccm;130;125;129;133;127;140;146;157;148;139 12:09:45 INFO - PROCESS | 1679 | |12;stanford-crypto-pbkdf2;169;166;171;186;225;181;167;164;163;160 12:09:45 INFO - PROCESS | 1679 | |13;stanford-crypto-sha256-iterative;59;65;65;61;68;67;66;69;68;67 12:09:45 INFO - PROCESS | 1679 | __end_tp_report 12:09:45 INFO - PROCESS | 1679 | __start_cc_report 12:09:45 INFO - PROCESS | 1679 | _x_x_mozilla_cycle_collect,1045 12:09:45 INFO - PROCESS | 1679 | __end_cc_report 12:09:45 INFO - PROCESS | 1679 | __startTimestamp1467054585849__endTimestamp 12:09:45 INFO - PROCESS | 1679 | 12:09:45 INFO - PROCESS | 1679 | ------- Summary: start ------- 12:09:45 INFO - PROCESS | 1679 | Number of tests: 14 12:09:45 INFO - PROCESS | 1679 | 12:09:45 INFO - PROCESS | 1679 | [#0] ai-astar Cycles:10 Average:116.90 Median:116.50 stddev:6.28 (5.4%) stddev-sans-first:6.66 12:09:45 INFO - PROCESS | 1679 | Values: 117.0 106.0 116.0 118.0 117.0 132.0 116.0 116.0 116.0 115.0 12:09:45 INFO - PROCESS | 1679 | 12:09:45 INFO - PROCESS | 1679 | [#1] audio-beat-detection Cycles:10 Average:148.90 Median:155.50 stddev:29.28 (18.8%) stddev-sans-first:30.94 12:09:45 INFO - PROCESS | 1679 | Values: 156.0 122.0 143.0 161.0 119.0 135.0 176.0 113.0 209.0 155.0 12:09:45 INFO - PROCESS | 1679 | 12:09:45 INFO - PROCESS | 1679 | [#2] audio-dft Cycles:10 Average:209.10 Median:198.00 stddev:24.31 (12.3%) stddev-sans-first:17.86 12:09:45 INFO - PROCESS | 1679 | Values: 259.0 251.0 198.0 201.0 196.0 196.0 196.0 198.0 198.0 198.0 12:09:45 INFO - PROCESS | 1679 | 12:09:45 INFO - PROCESS | 1679 | [#3] audio-fft Cycles:10 Average:80.40 Median:61.50 stddev:38.98 (63.4%) stddev-sans-first:40.99 12:09:45 INFO - PROCESS | 1679 | Values: 66.0 78.0 73.0 145.0 56.0 57.0 57.0 67.0 159.0 46.0 12:09:45 INFO - PROCESS | 1679 | 12:09:45 INFO - PROCESS | 1679 | [#4] audio-oscillator Cycles:10 Average:103.50 Median:105.50 stddev:21.79 (20.7%) stddev-sans-first:21.39 12:09:45 INFO - PROCESS | 1679 | Values: 80.0 81.0 134.0 114.0 116.0 118.0 120.0 77.0 78.0 117.0 12:09:45 INFO - PROCESS | 1679 | 12:09:45 INFO - PROCESS | 1679 | [#5] imaging-gaussian-blur Cycles:10 Average:90.00 Median:91.50 stddev:2.00 (2.2%) stddev-sans-first:1.99 12:09:45 INFO - PROCESS | 1679 | Values: 92.0 89.0 92.0 88.0 91.0 87.0 92.0 89.0 92.0 88.0 12:09:45 INFO - PROCESS | 1679 | 12:09:45 INFO - PROCESS | 1679 | [#6] imaging-darkroom Cycles:10 Average:114.40 Median:96.50 stddev:23.06 (23.9%) stddev-sans-first:23.56 12:09:45 INFO - PROCESS | 1679 | Values: 132.0 107.0 152.0 153.0 115.0 97.0 98.0 97.0 96.0 97.0 12:09:45 INFO - PROCESS | 1679 | 12:09:45 INFO - PROCESS | 1679 | [#7] imaging-desaturate Cycles:10 Average:97.30 Median:90.50 stddev:11.35 (12.5%) stddev-sans-first:11.73 12:09:45 INFO - PROCESS | 1679 | Values: 90.0 92.0 91.0 90.0 90.0 91.0 116.0 119.0 91.0 103.0 12:09:45 INFO - PROCESS | 1679 | 12:09:45 INFO - PROCESS | 1679 | [#8] json-parse-financial Cycles:10 Average:72.90 Median:72.00 stddev:14.62 (20.3%) stddev-sans-first:14.48 12:09:45 INFO - PROCESS | 1679 | Values: 58.0 65.0 62.0 66.0 89.0 98.0 90.0 78.0 63.0 60.0 12:09:45 INFO - PROCESS | 1679 | 12:09:45 INFO - PROCESS | 1679 | [#9] json-stringify-tinderbox Cycles:10 Average:69.80 Median:69.50 stddev:9.37 (13.5%) stddev-sans-first:9.50 12:09:45 INFO - PROCESS | 1679 | Values: 62.0 63.0 70.0 67.0 69.0 70.0 71.0 95.0 65.0 66.0 12:09:45 INFO - PROCESS | 1679 | 12:09:45 INFO - PROCESS | 1679 | [#10] stanford-crypto-aes Cycles:10 Average:81.80 Median:82.50 stddev:1.75 (2.1%) stddev-sans-first:1.83 12:09:45 INFO - PROCESS | 1679 | Values: 81.0 83.0 83.0 82.0 80.0 79.0 81.0 81.0 85.0 83.0 12:09:45 INFO - PROCESS | 1679 | 12:09:45 INFO - PROCESS | 1679 | [#11] stanford-crypto-ccm Cycles:10 Average:137.40 Median:139.50 stddev:10.47 (7.5%) stddev-sans-first:10.76 12:09:45 INFO - PROCESS | 1679 | Values: 130.0 125.0 129.0 133.0 127.0 140.0 146.0 157.0 148.0 139.0 12:09:45 INFO - PROCESS | 1679 | 12:09:45 INFO - PROCESS | 1679 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.20 Median:170.00 stddev:19.27 (11.3%) stddev-sans-first:20.31 12:09:45 INFO - PROCESS | 1679 | Values: 169.0 166.0 171.0 186.0 225.0 181.0 167.0 164.0 163.0 160.0 12:09:45 INFO - PROCESS | 1679 | 12:09:45 INFO - PROCESS | 1679 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.50 Median:67.00 stddev:3.21 (4.8%) stddev-sans-first:2.39 12:09:45 INFO - PROCESS | 1679 | Values: 59.0 65.0 65.0 61.0 68.0 67.0 66.0 69.0 68.0 67.0 12:09:45 INFO - PROCESS | 1679 | -------- Summary: end -------- 12:09:45 INFO - PROCESS | 1679 | 12:09:46 INFO - TEST-INFO | 1679: exit 0 12:09:46 INFO - TEST-OK | kraken | took 58751ms 12:09:46 INFO - SUITE-END | took 1168s 12:09:47 INFO - Completed test suite (00:19:28) 12:09:47 INFO - javascript benchmark 12:09:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3624.8550057997677, 3653.9269214615724, 3677.411614141738, 3700.2599480103986, 3706.48109264703, 5967.970160149204, 5969.462748352653, 5969.791057312995, 6008.609440386383, 6017.4885134763545, 5946.732397042133, 5951.434613711701, 5984.0, 6014.428629280223, 6025.246844144482, 5351.57187425006, 5378.838634840941, 5388.973055134719, 5433.6196466247375, 5493.725313734317, 5365.7585408656705, 5433.049216387136, 5471.480209380103, 5477.835664930059, 5488.341399032121, 5423.559398270774, 5445.319335083114, 5449.455054494559, 5478.945210547883, 5555.916661250085, 5379.946200538003, 5483.890322193573, 5500.22996780451, 5503.752331145108, 5514.448555144493, 5297.920531192035, 5382.165764306539, 5392.352917649907, 5455.427180146107, 5458.754356053987, 5564.8330550083565, 5700.37295897451, 5910.645361278337, 5913.586048976574, 6006.129111278884, 6222.719977601018, 6233.906491402633, 6240.469560087398, 6246.3441338659695, 6252.87494250117, 6236.0, 6252.3122456529745, 6258.06129080637, 6276.623402595813, 6286.937130628681, 5276.841694749125, 5863.882722345572, 6014.458698717092, 6028.909566356509, 6090.939090609126, 6388.201474815648, 6451.096846441502, 6476.222853257639, 6482.12491313676, 6486.513511486657, 6240.781572644935, 6242.875142497124, 6246.46905013079, 6255.999040153553, 6260.624362538262, 5985.910211346833, 6262.09199666055, 6295.24457065146, 6358.586691865014, 6360.52296077796, 6213.627182369072, 6247.094171345129, 6249.531285153632, 6250.656213908188, 6251.062340648939, 6145.170401995673, 6193.907091393633, 6238.251409830758, 6266.342034086447, 6269.404406581368, 4308.504521980012, 4986.750662466862, 5044.520770526794, 5066.138756411419, 5102.515261050195, 4155.58444155582, 4590.196715574828, 4603.263477843529, 4606.170889239902, 4608.677392582487, 5855.151003104526, 6034.9396506035255, 6072.149899014142, 6090.269167699905, 6099.512039036867, 6134.038624681888, 6208.9689551551955, 6271.3415091414745, 6283.905741413882, 6312.905306420407, 6026.758929642853, 6105.450509454082, 6112.755489780359, 6123.908141377883, 6141.84645383869, 5500.064988951888, 5518.2826232589505, 5547.611667183259, 5617.747201375948, 5626.521745651584, 6598.0, 6608.801735947929, 6619.0733297339375, 6622.569532980341, 6632.469402447792, 6369.649669268235, 6372.203474565679, 6379.393957574023, 6384.042393640991, 6397.808065758035, 6362.395572420613, 6416.51876109303, 6520.804375868732, 6570.638614876228, 6587.308332625005, 6253.843653908507, 6255.0, 6290.2766181889665, 6291.402316779899, 6296.307406185408, 6272.529560282906, 6312.558120931674, 6328.335524769833, 6342.524310676626, 6378.553501254868, 5834.9205397, 5850.297964244318, 6140.1710769047395, 6148.415900489446, 6234.0337247726675, 6152.723127459186, 6205.5345849060595, 6218.689065546795, 6231.470325022424, 6233.781817636361, 5152.330197074356, 6099.420555047263, 6214.9067763984485, 6237.594556353823, 6255.31191568918, 6143.082036032849, 6192.318844927145, 6220.906686399798, 6233.314335423191, 6254.906176407449, 6141.938580614136, 6154.630722156506, 6157.107219453064, 6166.290876549254, 6177.660228687465], "value": 5857.674799411904, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [509.7349378323272, 578.7511370110852, 583.9970800145999, 590.7489317040257, 595.3867516458047, 37261.0, 39542.406863897064, 40109.99999999996, 40165.0, 40195.59804401955, 42996.92507687309, 43703.344449833196, 43751.0, 43773.78113109438, 43835.90410239746, 9791.608335666564, 10001.249906257024, 10007.199424046059, 10023.44871032093, 10035.799284014316, 9802.558884850163, 9820.852687209697, 9857.162141217968, 9903.900960990406, 9921.362975109098, 8449.788755281106, 9881.604735810559, 9889.25830562707, 9959.452230127341, 9973.850392244121, 9891.060349266809, 9911.157551608158, 9936.602535898555, 9946.452945088018, 9987.500624968796, 9815.067568580973, 9862.45756483393, 9883.01169883013, 9887.80224395508, 9950.353227040292, 39755.60244397548, 39859.60140398617, 39904.80285591408, 40362.59637403618, 40436.191276174606, 3217.5978002749657, 3373.96626033739, 3390.135515443571, 3455.3089382123426, 3749.2876353492748, 25403.364915877068, 26985.650717464046, 28762.712372876213, 29050.33503509899, 29431.558526622117, 2773.209635253943, 2799.2861820235707, 2839.0489186122672, 2846.117703511918, 2883.884644614213, 467752.0, 470998.0, 478200.0, 479774.0, 480092.59953700006, 37632.62367376346, 66122.0, 66557.66721166363, 66569.0, 67594.0, 37060.25879482449, 37209.0, 37220.627793722255, 37246.813765930994, 37278.81360593234, 13819.378127984264, 16429.342826287055, 16438.917805410896, 17021.91489042547, 17040.31838726437, 14294.428222870969, 14554.636134096732, 14579.198144102176, 14580.489682861049, 14605.92697036508, 7332.670029848669, 8411.074781774, 8528.403011789114, 8558.828823423497, 8611.870821937677, 3275.950860737091, 3521.7534772565673, 3567.090391950036, 3630.673239408466, 3641.6540428659237, 1045.4197920154236, 1045.743792770776, 1048.2033654422542, 1096.030013438113, 1128.3060917535656, 23661.0, 30121.548176777367, 30464.0, 30575.235619109255, 30750.384992300027, 1009.9495025248708, 1137.2437329176005, 1164.2025212729138, 1200.9579664711694, 1303.88916942061, 15596.454124105829, 15669.0, 15742.370305187893, 15766.817488688393, 16043.0, 646864.7656761686, 649860.0, 651787.0, 657759.0, 659054.0, 63367.6831615839, 63886.36113638897, 63903.0, 64094.0, 64151.716965660424, 1560.742477491224, 1570.9842901571067, 1588.269396077794, 1596.1221328269637, 1606.3173151410838, 29500.11499655014, 29952.550711738906, 30025.5496167562, 30714.232144196572, 30819.383612328078, 55329.0, 55387.44612553823, 55634.0, 55748.0, 55775.442245577025, 472201.0, 484724.0, 487011.0, 487513.0, 487980.0, 27325.590116147876, 28128.85935570309, 28515.0, 44303.77848110739, 44864.55135448735, 44345.0, 44982.0, 45649.54350456453, 45742.0, 47122.293165601855, 37972.86081417562, 38208.617913820504, 38438.0, 38630.22739545249, 38846.61153388543, 37626.43560346542, 37951.430728538544, 38091.42862857004, 38172.04569885664, 38857.417138743505, 36676.63323366732, 36886.63113368832, 38021.619783801805, 38087.66693165726, 38153.236935261695, 32557.511637325933, 32947.528935330425, 33149.50275745914, 33454.49818252777, 33675.0, 25365.0, 25532.23403297904, 25604.23187304384, 25834.0, 26280.8685956569], "value": 19232.727034093034, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [388.24292629372724, 415.49102349621717, 418.36617524450463, 421.4247552091392, 430.99138017239653, 20968.475788105305, 21404.0, 21704.565908681838, 21768.564628707416, 22396.992135353907, 12172.0, 12879.969602431807, 18457.35399261026, 22137.225197118103, 22447.55104897901, 5271.367435907697, 5388.91916621251, 5740.512056475184, 6300.716467758962, 6310.305866354697, 6126.969365153191, 6131.47882429994, 6135.601185922901, 6222.595531290452, 6246.25044994599, 5902.586818922677, 6074.908876366858, 6204.379562043805, 6216.720247588847, 6230.719617617218, 6122.051082082285, 6137.110119032737, 6150.231221097363, 6163.167972323724, 6180.227471566054, 5319.601029922771, 5379.085555455543, 5454.863628409282, 5481.835544933659, 5546.91679624806, 20042.599148017103, 26241.21276361712, 26667.33331666724, 27069.729302707114, 27793.86103069492, 2107.8102970732552, 2231.665250212481, 2465.6917885264343, 2546.987265063663, 2843.3460304130167, 10238.18094552434, 10457.267991240617, 10467.84298235527, 10509.737256568647, 10511.73720656982, 1830.2404502131599, 1851.1762265791729, 1859.8698091133626, 1876.2026138890917, 1932.1981377728225, 83288.58355708183, 120450.5909881815, 123103.0, 125548.0, 128532.0, 10208.336458130347, 11925.522979080739, 12221.144519883523, 12317.630471085882, 12412.441440135215, 15546.9222653886, 15734.842651573566, 15850.603734906488, 15996.76004859928, 16052.117133557533, 9559.952200238955, 9609.423434593808, 9626.65226868239, 9704.757381065388, 9757.219422446187, 9697.709068727949, 9765.462899540593, 9789.853152202722, 9794.432890737591, 9851.802963940681, 4924.4090709115135, 4932.7533623319405, 4956.281339205795, 4969.801207951641, 4976.154053810788, 2058.639738045836, 2127.978720212809, 2131.8294536437047, 2135.839812014105, 2170.7178066851206, 903.503073309677, 1001.3741411617739, 1042.7080417483116, 1071.7320669832543, 1096.2271598523023, 21176.89411552963, 21268.468288292606, 21434.57130857374, 21720.674189887166, 21756.0, 972.3193764364972, 997.486294558303, 1015.4262841494532, 1048.8741351037772, 1073.1200415659084, 11196.608118715805, 11516.539338426537, 11551.0, 11565.884341156481, 11608.825867611993, 633535.0, 636730.0, 646047.0, 648513.0, 649617.0, 79411.0, 133919.0, 138719.61280387067, 139198.0, 139637.6036239645, 1059.1156384419096, 1117.502711293483, 1133.3369978562469, 1136.108155098244, 1137.0448822988728, 18622.53443663919, 18671.41292990111, 19231.711524327427, 19289.035548222815, 19487.512812179808, 39404.0, 56852.0, 57252.713736431055, 57360.71319643375, 61206.77586448335, 81123.59438203007, 84641.73037404321, 85087.0, 85763.71354429564, 86235.56882215549, 8462.619182136696, 8510.531920744419, 8591.140885911358, 8672.479651220947, 8712.91287087121, 9408.858867117136, 12381.257124572554, 13067.542636007694, 13232.470701171846, 13266.403011864297, 10955.616553420592, 11374.772504550028, 11403.600873969703, 11427.971482566609, 11592.072634189077, 11061.11511079128, 11236.213465057368, 11350.318980860844, 11490.540378385105, 11582.073434125417, 11582.594609188638, 11649.825252621387, 11697.06423486136, 11776.11679124052, 11812.0, 8035.718749843727, 8430.550628768873, 8434.283085937765, 8707.564621768759, 8830.955845220733, 8460.788480287796, 10619.256652034592, 11686.824697629712, 11697.2981621103, 11780.352080635646], "value": 9976.595760592974, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1455.345094707382, 1595.1306537936823, 1617.7007253658073, 1974.8025197480263, 2016.1229865008713, 8358.874616880752, 9034.548272586377, 9116.544172791359, 9361.0, 9361.48511831849, 9048.230900373459, 9055.094490550942, 9212.986571477131, 9252.768680782967, 9265.30510211735, 2127.585120901425, 2523.8485690858515, 2527.431327951215, 2533.607290869918, 2553.2978430931457, 2260.525289689167, 2389.991414690309, 2562.1160699558623, 2585.9612105818333, 2586.8706564671784, 2537.4671319023028, 2556.1181392419585, 2564.8589327586974, 2565.9230223093336, 2567.9101231456902, 2528.1783420388356, 2534.6451496790464, 2568.935776605581, 2571.5628343181515, 2572.3826281692445, 2540.4538024324675, 2558.5650439425344, 2569.203546900467, 2575.2016874768883, 2596.0135148643585, 9312.301577381655, 9347.859782103274, 9349.953250233706, 9363.812723745556, 9368.016358282419, 4871.756412179377, 5678.829635110953, 5704.458076482728, 5822.155787410802, 5863.179154918314, 3648.9270214595826, 3747.756395834262, 3753.6246375362516, 3762.698984081267, 3831.3103641344546, 1053.8682664666917, 1068.5298468673836, 1089.1395797320108, 1089.9509522071526, 1094.8029354716148, 12409.317487538181, 12445.62663120108, 12520.624381268577, 12550.372481375985, 12585.74828503434, 5070.670406423571, 5119.795208191705, 5155.716435596079, 5157.793688252503, 5233.188855727369, 10566.682999510027, 10623.681289561326, 10668.733281667865, 10675.57297708083, 10732.980366865135, 5799.536037117021, 5818.330891947396, 5844.620099693507, 5848.385919478478, 5880.0, 4645.72125672454, 5053.9494605054215, 5141.0, 5169.974150129226, 5234.816781412708, 4273.9358909616385, 4290.206311832321, 4355.869323920288, 4363.912721745611, 4366.825326986885, 1406.296851574213, 1424.173979092124, 1430.7710766277346, 1435.842057373688, 1440.337444775394, 946.668665966906, 947.3842002698301, 967.8693376394237, 971.5336638413601, 978.5498670611598, 6009.489193418608, 6072.605280656743, 6103.6032657877095, 6153.600015998945, 6207.937920620826, 466.4985140973467, 476.71158948835455, 481.52569718826925, 1062.824633935392, 1064.090202876545, 4010.7593544387432, 4086.387041943732, 4097.631213190767, 4111.794410279534, 4132.938005929914, 10871.402072886067, 11472.024877885473, 11563.537458501734, 11566.595169169039, 11607.187496875307, 10925.562977480811, 11243.156763242627, 11334.206605537698, 11370.772584548262, 11395.031422329195, 8758.343124265706, 8817.867731984026, 8887.244584210286, 8907.331950103639, 8933.15135062168, 5766.94233057664, 5941.287045554561, 5996.640201587918, 5997.940020599913, 6021.789237376671, 10015.949920250643, 10058.0, 10138.645147419806, 10154.746131346776, 10284.0, 10121.746956325856, 10530.210234232616, 10540.736481588021, 10551.736206594896, 10744.570217191225, 6618.801435956929, 7242.203357630762, 7305.5981920994855, 7399.223081576357, 7492.438067145095, 8479.109693482342, 8606.311495080503, 8651.394402391772, 8652.610632521426, 8707.695230666895, 6563.9343606563325, 7646.388288936983, 7692.269234422721, 7764.92235077642, 7868.213178682086, 7547.28300811422, 7551.244875512405, 7581.355584775356, 7641.35048520882, 7711.845763084595, 6291.0, 7145.1425828900865, 7236.34872861445, 7236.746713864989, 7242.275772422716, 4964.851054468371, 4989.575886049726, 5052.823151189691, 5161.896762064663, 5168.870778230575, 5119.334486516729, 5120.871978200575, 5224.791008359623, 5342.98483288174, 5352.839414817562], "value": 4792.09188064409, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [333.0159379034951, 336.59440374348895, 337.71800546543636, 343.010414952861, 346.79712368264563, 6955.686994085266, 6981.1622605287375, 6998.370146686797, 6999.020137180799, 7017.6140312282805, 6822.761203357871, 6862.176538815336, 6885.345892140252, 6913.308669133085, 6915.757948471804, 4073.490813648294, 4872.731999740022, 4948.183549714293, 5076.974615126937, 5095.898082038357, 5015.3730783652045, 5076.416212135615, 5077.187649976005, 5095.955329157532, 5096.770645320969, 5017.774200160983, 5032.396112466509, 5034.82378116766, 5052.772625231855, 5055.3933527976515, 5025.84922452327, 5049.772760225798, 5062.190049592066, 5076.695398276115, 5085.516875896784, 3550.786952782841, 3557.2707594942976, 4359.738415695068, 4370.497392799805, 4374.387585737999, 6444.291127975919, 6606.966965165191, 6661.134052573135, 6672.7330906764155, 6687.465002799764, 5970.6716130612795, 6009.248843894513, 6011.30869949957, 6014.2181516403025, 6035.253959448441, 7406.666699998513, 7435.8141046474275, 7436.888446673304, 7445.329920307198, 7465.664045117983, 4906.994066216417, 4932.630052746023, 4935.136351138536, 4948.307236986825, 4954.975225123887, 7710.587052732767, 7789.493682910593, 7888.171741967069, 7903.960480197619, 7915.406344524184, 4056.9797151014645, 4161.0, 5007.774650140753, 5010.649254552146, 5038.748062596856, 4181.560936101726, 4576.4737055239075, 4763.356946812205, 5085.211792172219, 5130.076586214443, 5945.821625351246, 5987.491063259585, 5989.161517387569, 6000.639961602318, 6014.368491308437, 7486.326230639269, 7497.812554686067, 7500.737474188377, 7508.3993280537425, 7509.061367329084, 1655.7019736447555, 1781.100544225184, 1802.3691707902392, 1808.0236672196866, 1810.4025671528364, 1070.2829104500004, 1086.6794295682791, 1095.906847917936, 1097.155190503308, 1098.774751176023, 6958.443324534025, 7038.436925045984, 7046.6476676165985, 7062.0, 7087.92912070883, 6304.401081897213, 7583.924160758432, 7776.783616669222, 7790.805229869298, 7799.805004874924, 6947.965260173768, 7055.0475685782785, 7066.611336376549, 7068.974998625171, 7116.110486189226, 4101.89745256365, 4211.326187809997, 4256.787160641956, 4267.338562522752, 4275.4441922550495, 6665.833354166088, 8310.83378332442, 8316.625751841182, 8320.958395208107, 8326.916730832736, 6350.618962862243, 8192.722910835713, 8204.097549269694, 8234.670613175405, 8239.835203296021, 8271.503709777433, 8296.709615163561, 8299.875501867476, 8333.958330208432, 8358.289545388589, 7910.802229944297, 7920.0, 7932.444728868923, 7955.164707705608, 7993.960030199812, 7762.961185194038, 7763.844723105393, 7764.611769411394, 7778.649960751893, 7780.572068536058, 7978.601069946596, 8252.133525979925, 8290.502569845587, 8307.875381869157, 8365.623546940524, 4870.1964175912, 4875.609951203966, 4927.975360123177, 4929.16204245272, 4933.6299777516115, 5629.831105066854, 6509.902351464826, 7855.5286682799215, 7861.842763144591, 7871.645775939982, 6156.768646270674, 7537.510061845963, 7589.848203036019, 7595.08858936909, 7609.505382150142, 6998.930010699828, 7517.173110957681, 7542.2834830691, 7543.698252070075, 7556.433267504849, 6073.5748497604745, 7233.927660723325, 7395.519291246052, 7406.925930740624, 7415.740449084472, 5810.01229790945, 7377.372923301579, 7557.395408367208, 7568.091828980558, 7735.6905723770415, 7179.748708795376, 7370.078740157481, 7376.225496322809, 7377.5204611700065, 7408.62956852166], "value": 5420.970839799998, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [683.0846665468272, 724.8622761675282, 758.3099379564594, 777.8016605765528, 778.1829079466562, 15380.923095384522, 15549.611259718513, 15615.375384984616, 15664.373425062984, 15716.685666286667, 14376.856231437683, 14385.496507622236, 14402.567922962327, 14408.855911440882, 14410.919181061436, 758.2758465665277, 899.8965119011316, 915.244922938575, 917.2295271971576, 925.708401853414, 890.5458216309664, 907.3467103685336, 922.3635691372965, 925.8102089071724, 948.9762755931088, 927.420362273579, 934.2759361494828, 964.4068897627978, 969.0116081596802, 992.136840948376, 926.36081104038, 927.4713413354391, 962.6630679262272, 966.6713317472058, 993.006993006993, 647.0843756085134, 724.2467833453202, 752.9435292353096, 753.8228516298666, 758.1281526244808, 15141.167235802026, 15172.696546069128, 15172.772408413883, 15196.316165772456, 15341.079535227811, 12956.870431295662, 12970.092093553456, 13152.210867347894, 13216.140950838164, 13218.07473476857, 10166.339187952759, 10261.127804136582, 10351.430671313075, 10379.42913139777, 10419.635312764018, 3567.661072198163, 3601.1537288737127, 3614.0964758810296, 3638.6543278388513, 3810.428435734634, 83957.7224819719, 87474.12525874724, 87945.68081478847, 88279.35161945153, 89164.5541772287, 9409.717708468757, 9546.140847323635, 9627.374220675634, 9679.274054445945, 9975.0, 21926.780732192794, 22624.773752262266, 22632.207872724375, 22684.319470415914, 22711.88644056769, 7732.226777322336, 7831.608419578998, 7873.606319683993, 7913.248241417056, 7990.960045199853, 4141.026858688206, 4188.748675079505, 4204.180184863983, 4211.157768446323, 4234.640055595247, 3638.4542318652416, 3752.1932784451474, 3804.1630841214887, 3811.294910441577, 3896.6687831534637, 698.0332239847847, 704.7181127549021, 715.3347386930205, 721.8195451137216, 722.0937723157404, 568.7525926222024, 574.5461085742216, 582.7290310005868, 594.4382558482192, 595.787572290387, 7716.48358226822, 8115.188481151838, 8294.709685160991, 8296.83406331882, 8385.6226469809, 470.3109943932156, 509.806273616031, 566.6005466146357, 571.5056476148102, 587.5769445998959, 3769.3403654360377, 3872.9225415491533, 3897.9220415592094, 3947.388154836005, 4054.574269701639, 87720.0, 87737.0, 88207.55896220607, 90112.6483102754, 90528.0, 57534.0, 79797.60101199457, 79949.0, 80983.59508202421, 81619.7757033645, 68308.6584567074, 69462.61074778475, 69808.6509567449, 70209.89370318898, 70856.93714594285, 7742.0, 7873.842523149619, 8567.571621419029, 8635.870461943201, 8728.912710873064, 43563.78218108889, 46325.76837115793, 50444.0, 50866.74566627143, 50917.727056823875, 50823.745881270355, 66873.66563167152, 70990.64504677443, 73373.53252935018, 74418.62790686011, 9280.814383712153, 10896.0, 11237.213395062266, 11304.152188585724, 11475.368854713071, 12098.516059357527, 12217.266963982189, 12264.877351226374, 12423.317458265936, 12637.810432843698, 11416.0, 11572.074234061087, 11642.88357116418, 11681.415929203336, 11720.0, 11690.47392867306, 11805.82291265649, 11877.346745929057, 12006.039516838806, 12231.327276999851, 11477.36874471912, 11640.126990475579, 11766.117541184274, 11857.40712964331, 11968.521259149536, 9952.402855828674, 9979.151772099163, 10082.143017843566, 10125.949370253102, 10379.636712715019, 9900.356476828983, 10096.0, 10119.595216191565, 10121.0, 10177.287589868934], "value": 7040.784680395076, "unit": "score"}], "name": "dromaeo_css", "value": 7682.470054708851, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 106.0, 116.0, 118.0, 117.0, 132.0, 116.0, 116.0, 116.0, 115.0], "value": 116.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 122.0, 143.0, 161.0, 119.0, 135.0, 176.0, 113.0, 209.0, 155.0], "value": 148.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [259.0, 251.0, 198.0, 201.0, 196.0, 196.0, 196.0, 198.0, 198.0, 198.0], "value": 209.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 78.0, 73.0, 145.0, 56.0, 57.0, 57.0, 67.0, 159.0, 46.0], "value": 80.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 81.0, 134.0, 114.0, 116.0, 118.0, 120.0, 77.0, 78.0, 117.0], "value": 103.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 89.0, 92.0, 88.0, 91.0, 87.0, 92.0, 89.0, 92.0, 88.0], "value": 90.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 107.0, 152.0, 153.0, 115.0, 97.0, 98.0, 97.0, 96.0, 97.0], "value": 114.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 92.0, 91.0, 90.0, 90.0, 91.0, 116.0, 119.0, 91.0, 103.0], "value": 97.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 65.0, 62.0, 66.0, 89.0, 98.0, 90.0, 78.0, 63.0, 60.0], "value": 72.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 70.0, 67.0, 69.0, 70.0, 71.0, 95.0, 65.0, 66.0], "value": 69.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 83.0, 83.0, 82.0, 80.0, 79.0, 81.0, 81.0, 85.0, 83.0], "value": 81.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 125.0, 129.0, 133.0, 127.0, 140.0, 146.0, 157.0, 148.0, 139.0], "value": 137.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 166.0, 171.0, 186.0, 225.0, 181.0, 167.0, 164.0, 163.0, 160.0], "value": 175.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 65.0, 65.0, 61.0, 68.0, 67.0, 66.0, 69.0, 68.0, 67.0], "value": 65.5, "unit": "score"}], "name": "kraken", "value": 1563.1, "alertThreshold": 2.0}]} 12:09:47 INFO - Return code: 0 12:09:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 12:09:47 ERROR - # TBPL SUCCESS # 12:09:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:09:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:09:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:09:47 INFO - 2016-06-27 12:09:47.186 screenresolution[1684:10522] starting screenresolution argv=screenresolution get 12:09:47 INFO - 2016-06-27 12:09:47.188 screenresolution[1684:10522] Display 0: 1600x1200x32@60 12:09:47 INFO - 2016-06-27 12:09:47.194 screenresolution[1685:10525] starting screenresolution argv=screenresolution list 12:09:47 INFO - Available Modes on Display 0 12:09:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:09:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:09:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:09:47 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:09:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:09:47 INFO - Intel Iris: 12:09:47 INFO - Chipset Model: Intel Iris 12:09:47 INFO - Type: GPU 12:09:47 INFO - Bus: Built-In 12:09:47 INFO - VRAM (Dynamic, Max): 1536 MB 12:09:47 INFO - Vendor: Intel (0x8086) 12:09:47 INFO - Device ID: 0x0a2e 12:09:47 INFO - Revision ID: 0x0009 12:09:47 INFO - Displays: 12:09:47 INFO - Display: 12:09:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:09:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:09:47 INFO - Display Serial Number: 1600x1200 60 12:09:47 INFO - Main Display: Yes 12:09:47 INFO - Mirror: Off 12:09:47 INFO - Online: Yes 12:09:47 INFO - Rotation: Supported 12:09:47 INFO - Return code: 0 12:09:47 INFO - Running post-action listener: _resource_record_post_action 12:09:47 INFO - Running post-run listener: _resource_record_post_run 12:09:48 INFO - Total resource usage - Wall time: 1192s; CPU: 53.0%; Read bytes: 30890496; Write bytes: 496434176; Read time: 306; Write time: 1849 12:09:48 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 193409536; Write bytes: 185765888; Read time: 17685; Write time: 354 12:09:48 INFO - run-tests - Wall time: 1171s; CPU: 53.0%; Read bytes: 29067776; Write bytes: 300923904; Read time: 283; Write time: 1463 12:09:48 INFO - Running post-run listener: _upload_blobber_files 12:09:48 INFO - Blob upload gear active. 12:09:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:09:48 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 12:09:48 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'] 12:09:48 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 12:09:48 INFO - (blobuploader) - INFO - Open directory for files ... 12:09:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:09:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:09:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:09:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:09:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:09:49 INFO - (blobuploader) - INFO - Done attempting. 12:09:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:09:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:09:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:09:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:09:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:09:50 INFO - (blobuploader) - INFO - Done attempting. 12:09:50 INFO - (blobuploader) - INFO - Iteration through files over. 12:09:50 INFO - Return code: 0 12:09:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:09:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:09:50 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0962a8165509c9665b05ec0164ffd2578f9c2962fbfc66b46846902cfb7aefca7503339299cc101d3922a03b38f6a97f090660dc3c06fa2b83596942911e0acf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b34135cf5dd181ab28cf8f23f348e9f2867b3481c20eb8a9e8ac2a045738772b6ed1f762c15feafe87d6dece04bd158ce5628ee3b416f39b5b7b907c68db6a22"} 12:09:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:09:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:09:50 INFO - Contents: 12:09:50 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0962a8165509c9665b05ec0164ffd2578f9c2962fbfc66b46846902cfb7aefca7503339299cc101d3922a03b38f6a97f090660dc3c06fa2b83596942911e0acf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b34135cf5dd181ab28cf8f23f348e9f2867b3481c20eb8a9e8ac2a045738772b6ed1f762c15feafe87d6dece04bd158ce5628ee3b416f39b5b7b907c68db6a22"} 12:09:50 INFO - Running post-run listener: copy_logs_to_upload_dir 12:09:50 INFO - Copying logs to upload dir... 12:09:50 INFO - mkdir: /builds/slave/test/build/upload/logs 12:09:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1283.533429 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2016-06-27 12:09:50.703917) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 12:09:50.707107) ========= 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.XoXgwXe5Id/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.kgf8dWzmOp/Listeners TMPDIR=/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/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/0962a8165509c9665b05ec0164ffd2578f9c2962fbfc66b46846902cfb7aefca7503339299cc101d3922a03b38f6a97f090660dc3c06fa2b83596942911e0acf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b34135cf5dd181ab28cf8f23f348e9f2867b3481c20eb8a9e8ac2a045738772b6ed1f762c15feafe87d6dece04bd158ce5628ee3b416f39b5b7b907c68db6a22"} build_url:https://queue.taskcluster.net/v1/task/MzxqhptITsu9WN-TocNehg/artifacts/public/build/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011082 build_url: 'https://queue.taskcluster.net/v1/task/MzxqhptITsu9WN-TocNehg/artifacts/public/build/firefox-48.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0962a8165509c9665b05ec0164ffd2578f9c2962fbfc66b46846902cfb7aefca7503339299cc101d3922a03b38f6a97f090660dc3c06fa2b83596942911e0acf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b34135cf5dd181ab28cf8f23f348e9f2867b3481c20eb8a9e8ac2a045738772b6ed1f762c15feafe87d6dece04bd158ce5628ee3b416f39b5b7b907c68db6a22"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 12:09:50.739514) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 12:09:50.739838) ========= 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.XoXgwXe5Id/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.kgf8dWzmOp/Listeners TMPDIR=/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/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.004985 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 12:09:50.788624) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 12:09:50.788980) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 12:09:50.789349) ========= ========= Total master_lag: 0.16 =========