builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0126 starttime: 1485313111.89 results: success (0) buildid: 20170117083128 builduid: 766930557a084bc7938a387b284f4528 revision: 6a23526fe5168087d7e4132c0705aefcaed5f571 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-24 18:58:31.890398) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-24 18:58:31.890865) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-24 18:58:31.891146) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-24 18:58:31.927309) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 18:58:31.927555) ========= 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.QNtLpvW9Jc/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.V1um4lEnxM/Listeners TMPDIR=/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 --2017-01-24 18:58:31-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 161M=0s 2017-01-24 18:58:32 (161 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.284940 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 18:58:32.238081) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 18:58:32.238739) ========= 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.QNtLpvW9Jc/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.V1um4lEnxM/Listeners TMPDIR=/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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.026033 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 18:58:32.288072) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 18:58:32.288424) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 6a23526fe5168087d7e4132c0705aefcaed5f571 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 6a23526fe5168087d7e4132c0705aefcaed5f571 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.QNtLpvW9Jc/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.V1um4lEnxM/Listeners TMPDIR=/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 2017-01-24 18:58:32,391 truncating revision to first 12 chars 2017-01-24 18:58:32,391 Setting DEBUG logging. 2017-01-24 18:58:32,391 attempt 1/10 2017-01-24 18:58:32,391 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/6a23526fe516?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-24 18:58:33,041 unpacking tar archive at: mozilla-central-6a23526fe516/testing/mozharness/ program finished with exit code 0 elapsedTime=0.929651 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 18:58:33.242058) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-24 18:58:33.242394) ========= script_repo_revision: 6a23526fe5168087d7e4132c0705aefcaed5f571 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-24 18:58:33.242806) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-24 18:58:33.243071) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-24 18:58:33.260917) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-01-24 18:58:33.261339) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.QNtLpvW9Jc/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.V1um4lEnxM/Listeners TMPDIR=/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 18:58:33 INFO - MultiFileLogger online at 20170124 18:58:33 in /builds/slave/test 18:58:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 18:58:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:58:33 INFO - {'append_to_log': False, 18:58:33 INFO - 'base_work_dir': '/builds/slave/test', 18:58:33 INFO - 'blob_upload_branch': 'Firefox', 18:58:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:58:33 INFO - 'branch': 'Firefox', 18:58:33 INFO - 'buildbot_json_path': 'buildprops.json', 18:58:33 INFO - 'config_files': ('talos/mac_config.py',), 18:58:33 INFO - 'default_actions': ('clobber', 18:58:33 INFO - 'read-buildbot-config', 18:58:33 INFO - 'download-and-extract', 18:58:33 INFO - 'populate-webroot', 18:58:33 INFO - 'create-virtualenv', 18:58:33 INFO - 'install', 18:58:33 INFO - 'run-tests'), 18:58:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:58:33 INFO - 'download_minidump_stackwalk': True, 18:58:33 INFO - 'download_symbols': 'ondemand', 18:58:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:58:33 INFO - 'tooltool.py': '/tools/tooltool.py', 18:58:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:58:33 INFO - '/tools/misc-python/virtualenv.py')}, 18:58:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:58:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:58:33 INFO - 'installer_path': 'installer.exe', 18:58:33 INFO - 'log_level': 'info', 18:58:33 INFO - 'log_name': 'talos', 18:58:33 INFO - 'log_to_console': True, 18:58:33 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 18:58:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 18:58:33 INFO - 'opt_config_files': (), 18:58:33 INFO - 'pip_index': False, 18:58:33 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:58:33 INFO - 'cmd': ('bash', 18:58:33 INFO - '-c', 18:58:33 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:58:33 INFO - 'enabled': True, 18:58:33 INFO - 'halt_on_failure': False, 18:58:33 INFO - 'name': 'check_screen_resolution'},), 18:58:33 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:58:33 INFO - 'cmd': ('bash', 18:58:33 INFO - '-c', 18:58:33 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:58:33 INFO - 'enabled': True, 18:58:33 INFO - 'halt_on_failure': False, 18:58:33 INFO - 'name': 'check_screen_resolution'},), 18:58:33 INFO - 'run_cmd_checks_enabled': True, 18:58:33 INFO - 'sps_profile': False, 18:58:33 INFO - 'sps_profile_interval': 0, 18:58:33 INFO - 'suite': 'dromaeojs', 18:58:33 INFO - 'system_bits': '32', 18:58:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:58:33 INFO - 'title': 't-yosemite-r7-0126', 18:58:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:58:33 INFO - 'use_talos_json': True, 18:58:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:58:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:58:33 INFO - 'work_dir': 'build'} 18:58:33 INFO - [mozharness: 2017-01-25 02:58:33.473517Z] Running clobber step. 18:58:33 INFO - Running pre-action listener: _resource_record_pre_action 18:58:33 INFO - Running main action method: clobber 18:58:33 INFO - rmtree: /builds/slave/test/build 18:58:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:58:36 INFO - Running post-action listener: _resource_record_post_action 18:58:36 INFO - [mozharness: 2017-01-25 02:58:36.536411Z] Finished clobber step (success) 18:58:36 INFO - [mozharness: 2017-01-25 02:58:36.536607Z] Running read-buildbot-config step. 18:58:36 INFO - Running pre-action listener: _resource_record_pre_action 18:58:36 INFO - Running main action method: read_buildbot_config 18:58:36 INFO - Using buildbot properties: 18:58:36 INFO - { 18:58:36 INFO - "project": "", 18:58:36 INFO - "product": "firefox", 18:58:36 INFO - "script_repo_revision": "production", 18:58:36 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 18:58:36 INFO - "repository": "", 18:58:36 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 18:58:36 INFO - "buildid": "20170117083128", 18:58:36 INFO - "pgo_build": "False", 18:58:36 INFO - "basedir": "/builds/slave/test", 18:58:36 INFO - "buildnumber": 30, 18:58:36 INFO - "slavename": "t-yosemite-r7-0126", 18:58:36 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 18:58:36 INFO - "platform": "yosemite_r7", 18:58:36 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 18:58:36 INFO - "branch": "mozilla-central", 18:58:36 INFO - "repo_path": "mozilla-central", 18:58:36 INFO - "revision": "6a23526fe5168087d7e4132c0705aefcaed5f571", 18:58:36 INFO - "stage_platform": "macosx64", 18:58:36 INFO - "builduid": "766930557a084bc7938a387b284f4528", 18:58:36 INFO - "slavebuilddir": "test" 18:58:36 INFO - } 18:58:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/GcbUBbm3Q2OUSE5H79AZ6Q/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 18:58:36 INFO - Running post-action listener: _resource_record_post_action 18:58:36 INFO - [mozharness: 2017-01-25 02:58:36.540029Z] Finished read-buildbot-config step (success) 18:58:36 INFO - [mozharness: 2017-01-25 02:58:36.540156Z] Running download-and-extract step. 18:58:36 INFO - Running pre-action listener: _resource_record_pre_action 18:58:36 INFO - Running main action method: download_and_extract 18:58:36 INFO - mkdir: /builds/slave/test/build/tests 18:58: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:58:36 INFO - trying https://queue.taskcluster.net/v1/task/GcbUBbm3Q2OUSE5H79AZ6Q/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 18:58:36 INFO - Downloading https://queue.taskcluster.net/v1/task/GcbUBbm3Q2OUSE5H79AZ6Q/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 18:58:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GcbUBbm3Q2OUSE5H79AZ6Q/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 18:58:37 INFO - Downloaded 1199 bytes. 18:58:37 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 18:58:37 INFO - Using the following test package requirements: 18:58:37 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 18:58:37 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 18:58:37 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 18:58:37 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 18:58:37 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 18:58:37 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 18:58:37 INFO - u'jsshell-mac.zip'], 18:58:37 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 18:58:37 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 18:58:37 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 18:58:37 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 18:58:37 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 18:58:37 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 18:58:37 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 18:58:37 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 18:58:37 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 18:58:37 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 18:58:37 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 18:58:37 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 18:58:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GcbUBbm3Q2OUSE5H79AZ6Q/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 18:58:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GcbUBbm3Q2OUSE5H79AZ6Q/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 18:58:37 INFO - Fetch https://queue.taskcluster.net/v1/task/GcbUBbm3Q2OUSE5H79AZ6Q/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 18:58:37 INFO - Expected file size: 16326298 18:58:37 INFO - Obtained file size: 16326298 18:58:44 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 18:58:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GcbUBbm3Q2OUSE5H79AZ6Q/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 18:58:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GcbUBbm3Q2OUSE5H79AZ6Q/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 18:58:44 INFO - Fetch https://queue.taskcluster.net/v1/task/GcbUBbm3Q2OUSE5H79AZ6Q/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 18:58:45 INFO - Expected file size: 16326298 18:58:45 INFO - Obtained file size: 16326298 18:58:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GcbUBbm3Q2OUSE5H79AZ6Q/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 18:58:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GcbUBbm3Q2OUSE5H79AZ6Q/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 18:58:51 INFO - Fetch https://queue.taskcluster.net/v1/task/GcbUBbm3Q2OUSE5H79AZ6Q/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 18:58:53 INFO - Expected file size: 14403463 18:58:53 INFO - Obtained file size: 14403463 18:58:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:58:53 INFO - trying https://queue.taskcluster.net/v1/task/GcbUBbm3Q2OUSE5H79AZ6Q/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 18:58:53 INFO - Downloading https://queue.taskcluster.net/v1/task/GcbUBbm3Q2OUSE5H79AZ6Q/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 18:58:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GcbUBbm3Q2OUSE5H79AZ6Q/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 18:58:56 INFO - Downloaded 70132302 bytes. 18:58:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GcbUBbm3Q2OUSE5H79AZ6Q/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 18:58:56 INFO - mkdir: /builds/slave/test/properties 18:58:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:58:56 INFO - Writing to file /builds/slave/test/properties/build_url 18:58:56 INFO - Contents: 18:58:56 INFO - build_url:https://queue.taskcluster.net/v1/task/GcbUBbm3Q2OUSE5H79AZ6Q/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 18:58:56 INFO - Running post-action listener: _resource_record_post_action 18:58:56 INFO - Running post-action listener: set_extra_try_arguments 18:58:56 INFO - [mozharness: 2017-01-25 02:58:56.958859Z] Finished download-and-extract step (success) 18:58:56 INFO - [mozharness: 2017-01-25 02:58:56.958977Z] Running populate-webroot step. 18:58:56 INFO - Running pre-action listener: _resource_record_pre_action 18:58:56 INFO - Running main action method: populate_webroot 18:58:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:58:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:58:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:58:56 INFO - '--tppagecycles', 18:58:56 INFO - '7'], 18:58:56 INFO - 'tests': ['tsvgm']}}, 18:58:56 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:58:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:58:56 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:58:56 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:58:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:58:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:58:56 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 18:58:56 INFO - 'talos_options': ['--disable-e10s'], 18:58:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:58:56 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 18:58:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:58:56 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 18:58:56 INFO - 'talos_options': ['--disable-e10s'], 18:58:56 INFO - 'tests': ['damp', 'tps']}, 18:58:56 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 18:58:56 INFO - 'tests': ['damp', 'tps']}, 18:58:56 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:58:56 INFO - 'tests': ['dromaeo_dom']}, 18:58:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:58:56 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:58:56 INFO - 'tests': ['basic_compositor_video']}, 18:58:56 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:58:56 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:58:56 INFO - 'tests': ['a11yr', 18:58:56 INFO - 'ts_paint', 18:58:56 INFO - 'tpaint', 18:58:56 INFO - 'sessionrestore', 18:58:56 INFO - 'sessionrestore_no_auto_restore', 18:58:56 INFO - 'tabpaint']}, 18:58:56 INFO - 'other-e10s': {'tests': ['a11yr', 18:58:56 INFO - 'ts_paint', 18:58:56 INFO - 'tpaint', 18:58:56 INFO - 'sessionrestore', 18:58:56 INFO - 'sessionrestore_no_auto_restore', 18:58:56 INFO - 'tabpaint']}, 18:58:56 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:58:56 INFO - 'ts_paint', 18:58:56 INFO - 'tpaint', 18:58:56 INFO - 'sessionrestore', 18:58:56 INFO - 'sessionrestore_no_auto_restore', 18:58:56 INFO - 'tabpaint']}, 18:58:56 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:58:56 INFO - 'ts_paint', 18:58:56 INFO - 'tpaint', 18:58:56 INFO - 'sessionrestore', 18:58:56 INFO - 'sessionrestore_no_auto_restore', 18:58:56 INFO - 'tabpaint']}, 18:58:56 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:58:56 INFO - 'tests': ['a11yr', 18:58:56 INFO - 'ts_paint', 18:58:56 INFO - 'tpaint', 18:58:56 INFO - 'sessionrestore', 18:58:56 INFO - 'sessionrestore_no_auto_restore', 18:58:56 INFO - 'tabpaint']}, 18:58:56 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:58:56 INFO - 'tests': ['a11yr', 18:58:56 INFO - 'ts_paint', 18:58:56 INFO - 'tpaint', 18:58:56 INFO - 'sessionrestore', 18:58:56 INFO - 'sessionrestore_no_auto_restore', 18:58:56 INFO - 'tabpaint']}, 18:58:56 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:58:56 INFO - 'tests': ['tsvgx', 18:58:56 INFO - 'tsvgr_opacity', 18:58:56 INFO - 'tart', 18:58:56 INFO - 'tscrollx', 18:58:56 INFO - 'cart', 18:58:56 INFO - 'tsvg_static']}, 18:58:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:58:56 INFO - 'tsvgr_opacity', 18:58:56 INFO - 'tart', 18:58:56 INFO - 'tscrollx', 18:58:56 INFO - 'cart', 18:58:56 INFO - 'tsvg_static']}, 18:58:56 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 18:58:56 INFO - 'talos_options': ['--disable-e10s'], 18:58:56 INFO - 'tests': ['tp5o']}, 18:58:56 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 18:58:56 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 18:58:56 INFO - 'talos_options': ['--disable-e10s', 18:58:56 INFO - '--xperf_path', 18:58:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:58:56 INFO - 'tests': ['tp5n']}, 18:58:56 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 18:58:56 INFO - 'talos_options': ['--xperf_path', 18:58:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:58:56 INFO - 'tests': ['tp5n']}}, 18:58:56 INFO - 'talos.zip': {'path': '', 18:58:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:58:56 INFO - Running post-action listener: _resource_record_post_action 18:58:56 INFO - [mozharness: 2017-01-25 02:58:56.977964Z] Finished populate-webroot step (success) 18:58:56 INFO - [mozharness: 2017-01-25 02:58:56.978100Z] Running create-virtualenv step. 18:58:56 INFO - Running pre-action listener: _resource_record_pre_action 18:58:56 INFO - Running main action method: create_virtualenv 18:58:56 INFO - Creating virtualenv /builds/slave/test/build/venv 18:58:56 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 18:58:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:58:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:58:57 INFO - Using real prefix '/tools/python27' 18:58:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:58:57 INFO - Installing distribute.............................................................................................................................................................................................done. 18:59:00 INFO - Installing pip.................done. 18:59:00 INFO - Return code: 0 18:59:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:59:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:59:00 INFO - Reading from file tmpfile_stdout 18:59:00 INFO - Output received: 18:59:00 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 18:59:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:59:00 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:59:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:59:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:00 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:59:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:59:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:00 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 0x104441b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104444768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe0b2486110>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10421fd30>, '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 0x104146db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104214be8>, '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.QNtLpvW9Jc/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.V1um4lEnxM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 18:59:00 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 18:59:00 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 18:59:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QNtLpvW9Jc/Render', 18:59:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:59:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:59:00 INFO - 'HOME': '/Users/cltbld', 18:59:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:59:00 INFO - 'LOGNAME': 'cltbld', 18:59:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:59:00 INFO - 'MOZ_NO_REMOTE': '1', 18:59:00 INFO - 'NO_EM_RESTART': '1', 18:59:00 INFO - 'PAGER': '/bin/cat', 18:59:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:59:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:59:00 INFO - 'PWD': '/builds/slave/test', 18:59:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:59:00 INFO - 'SHELL': '/bin/bash', 18:59:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.V1um4lEnxM/Listeners', 18:59:00 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 18:59:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:59:00 INFO - 'USER': 'cltbld', 18:59:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:59:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:59:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:59:00 INFO - 'XPC_FLAGS': '0x0', 18:59:00 INFO - 'XPC_SERVICE_NAME': '0', 18:59:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:59:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:59:01 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 18:59:01 INFO - Cleaning up... 18:59:01 INFO - Return code: 0 18:59:01 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:59:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:59:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:59:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:59:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:59:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104441b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104444768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe0b2486110>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10421fd30>, '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 0x104146db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104214be8>, '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.QNtLpvW9Jc/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.V1um4lEnxM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 18:59:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 18:59:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 18:59:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QNtLpvW9Jc/Render', 18:59:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:59:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:59:01 INFO - 'HOME': '/Users/cltbld', 18:59:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:59:01 INFO - 'LOGNAME': 'cltbld', 18:59:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:59:01 INFO - 'MOZ_NO_REMOTE': '1', 18:59:01 INFO - 'NO_EM_RESTART': '1', 18:59:01 INFO - 'PAGER': '/bin/cat', 18:59:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:59:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:59:01 INFO - 'PWD': '/builds/slave/test', 18:59:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:59:01 INFO - 'SHELL': '/bin/bash', 18:59:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.V1um4lEnxM/Listeners', 18:59:01 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 18:59:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:59:01 INFO - 'USER': 'cltbld', 18:59:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:59:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:59:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:59:01 INFO - 'XPC_FLAGS': '0x0', 18:59:01 INFO - 'XPC_SERVICE_NAME': '0', 18:59:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:59:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:59:01 INFO - Downloading/unpacking psutil>=3.1.1 18:59:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:59:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:59:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:59:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:59:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:59:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:59:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:59:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:59:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:59:04 INFO - Installing collected packages: psutil 18:59:04 INFO - Running setup.py install for psutil 18:59:05 INFO - building 'psutil._psutil_osx' extension 18:59:05 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 18:59:05 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 18:59:05 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 18:59:05 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 18:59:05 INFO - building 'psutil._psutil_posix' extension 18:59:05 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 18:59:05 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 18:59:05 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 18:59:05 INFO - ^ 18:59:05 INFO - 1 warning generated. 18:59:05 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 18:59:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:59:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:59:06 INFO - Successfully installed psutil 18:59:06 INFO - Cleaning up... 18:59:06 INFO - Return code: 0 18:59:06 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:59:06 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:59:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:59:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:06 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:59:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:59:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104441b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104444768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe0b2486110>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10421fd30>, '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 0x104146db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104214be8>, '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.QNtLpvW9Jc/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.V1um4lEnxM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 18:59:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 18:59:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 18:59:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QNtLpvW9Jc/Render', 18:59:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:59:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:59:06 INFO - 'HOME': '/Users/cltbld', 18:59:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:59:06 INFO - 'LOGNAME': 'cltbld', 18:59:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:59:06 INFO - 'MOZ_NO_REMOTE': '1', 18:59:06 INFO - 'NO_EM_RESTART': '1', 18:59:06 INFO - 'PAGER': '/bin/cat', 18:59:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:59:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:59:06 INFO - 'PWD': '/builds/slave/test', 18:59:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:59:06 INFO - 'SHELL': '/bin/bash', 18:59:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.V1um4lEnxM/Listeners', 18:59:06 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 18:59:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:59:06 INFO - 'USER': 'cltbld', 18:59:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:59:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:59:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:59:06 INFO - 'XPC_FLAGS': '0x0', 18:59:06 INFO - 'XPC_SERVICE_NAME': '0', 18:59:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:59:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:59:06 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:59:06 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 18:59:06 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 18:59:06 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 18:59:06 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 18:59:06 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 18:59:06 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 18:59:08 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:59:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:59:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:59:09 INFO - Installing collected packages: mozsystemmonitor 18:59:09 INFO - Running setup.py install for mozsystemmonitor 18:59:09 INFO - Successfully installed mozsystemmonitor 18:59:09 INFO - Cleaning up... 18:59:09 INFO - Return code: 0 18:59:09 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:59:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:59:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:59:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:59:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:59:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104441b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104444768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe0b2486110>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10421fd30>, '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 0x104146db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104214be8>, '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.QNtLpvW9Jc/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.V1um4lEnxM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 18:59:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 18:59:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 18:59:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QNtLpvW9Jc/Render', 18:59:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:59:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:59:09 INFO - 'HOME': '/Users/cltbld', 18:59:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:59:09 INFO - 'LOGNAME': 'cltbld', 18:59:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:59:09 INFO - 'MOZ_NO_REMOTE': '1', 18:59:09 INFO - 'NO_EM_RESTART': '1', 18:59:09 INFO - 'PAGER': '/bin/cat', 18:59:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:59:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:59:09 INFO - 'PWD': '/builds/slave/test', 18:59:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:59:09 INFO - 'SHELL': '/bin/bash', 18:59:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.V1um4lEnxM/Listeners', 18:59:09 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 18:59:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:59:09 INFO - 'USER': 'cltbld', 18:59:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:59:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:59:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:59:09 INFO - 'XPC_FLAGS': '0x0', 18:59:09 INFO - 'XPC_SERVICE_NAME': '0', 18:59:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:59:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:59:09 INFO - Downloading/unpacking jsonschema==2.5.1 18:59:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:59:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:59:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:59:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:59:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:59:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:59:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:59:12 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:59:12 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 18:59:12 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 18:59:12 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 18:59:12 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 18:59:12 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 18:59:12 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 18:59:12 INFO - Downloading functools32-3.2.3-2.tar.gz 18:59:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:59:12 INFO - warning: no files found matching '*.txt' 18:59:12 INFO - no previously-included directories found matching 'build' 18:59:12 INFO - no previously-included directories found matching 'dist' 18:59:12 INFO - no previously-included directories found matching '.git*' 18:59:12 INFO - Installing collected packages: jsonschema, functools32 18:59:12 INFO - Running setup.py install for functools32 18:59:12 INFO - warning: no files found matching '*.txt' 18:59:12 INFO - no previously-included directories found matching 'build' 18:59:12 INFO - no previously-included directories found matching 'dist' 18:59:12 INFO - no previously-included directories found matching '.git*' 18:59:12 INFO - Successfully installed jsonschema functools32 18:59:12 INFO - Cleaning up... 18:59:12 INFO - Return code: 0 18:59:12 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:59: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:59:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:59:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:59:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:59:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104441b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104444768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe0b2486110>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10421fd30>, '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 0x104146db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104214be8>, '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.QNtLpvW9Jc/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.V1um4lEnxM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 18:59:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 18:59:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 18:59:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QNtLpvW9Jc/Render', 18:59:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:59:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:59:12 INFO - 'HOME': '/Users/cltbld', 18:59:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:59:12 INFO - 'LOGNAME': 'cltbld', 18:59:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:59:12 INFO - 'MOZ_NO_REMOTE': '1', 18:59:12 INFO - 'NO_EM_RESTART': '1', 18:59:12 INFO - 'PAGER': '/bin/cat', 18:59:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:59:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:59:12 INFO - 'PWD': '/builds/slave/test', 18:59:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:59:12 INFO - 'SHELL': '/bin/bash', 18:59:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.V1um4lEnxM/Listeners', 18:59:12 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 18:59:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:59:12 INFO - 'USER': 'cltbld', 18:59:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:59:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:59:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:59:12 INFO - 'XPC_FLAGS': '0x0', 18:59:12 INFO - 'XPC_SERVICE_NAME': '0', 18:59:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:59:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:59:13 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:59:13 INFO - Cleaning up... 18:59:13 INFO - Return code: 0 18:59:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:59: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:59:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:59:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:59:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:59:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:13 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 0x104441b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104444768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe0b2486110>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10421fd30>, '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 0x104146db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104214be8>, '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.QNtLpvW9Jc/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.V1um4lEnxM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 18:59:13 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 18:59:13 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 18:59:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QNtLpvW9Jc/Render', 18:59:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:59:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:59:13 INFO - 'HOME': '/Users/cltbld', 18:59:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:59:13 INFO - 'LOGNAME': 'cltbld', 18:59:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:59:13 INFO - 'MOZ_NO_REMOTE': '1', 18:59:13 INFO - 'NO_EM_RESTART': '1', 18:59:13 INFO - 'PAGER': '/bin/cat', 18:59:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:59:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:59:13 INFO - 'PWD': '/builds/slave/test', 18:59:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:59:13 INFO - 'SHELL': '/bin/bash', 18:59:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.V1um4lEnxM/Listeners', 18:59:13 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 18:59:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:59:13 INFO - 'USER': 'cltbld', 18:59:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:59:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:59:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:59:13 INFO - 'XPC_FLAGS': '0x0', 18:59:13 INFO - 'XPC_SERVICE_NAME': '0', 18:59:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:59:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:59:13 INFO - Downloading/unpacking blobuploader==1.2.4 18:59:13 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 18:59:13 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 18:59:13 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 18:59:13 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 18:59:13 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 18:59:13 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 18:59:16 INFO - Downloading blobuploader-1.2.4.tar.gz 18:59:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:59:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:59:16 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 18:59:16 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 18:59:16 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 18:59:16 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 18:59:16 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 18:59:16 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 18:59:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:59:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:59:16 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 18:59:16 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 18:59:16 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 18:59:16 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 18:59:16 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 18:59:16 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 18:59:17 INFO - Downloading docopt-0.6.1.tar.gz 18:59:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:59:17 INFO - Installing collected packages: blobuploader, requests, docopt 18:59:17 INFO - Running setup.py install for blobuploader 18:59:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:59:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:59:17 INFO - Running setup.py install for requests 18:59:18 INFO - Running setup.py install for docopt 18:59:18 INFO - Successfully installed blobuploader requests docopt 18:59:18 INFO - Cleaning up... 18:59:18 INFO - Return code: 0 18:59:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:59:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:59:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:59:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:59:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:59:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:18 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 0x104441b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104444768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe0b2486110>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10421fd30>, '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 0x104146db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104214be8>, '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.QNtLpvW9Jc/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.V1um4lEnxM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 18:59:18 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 18:59:18 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 18:59:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QNtLpvW9Jc/Render', 18:59:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:59:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:59:18 INFO - 'HOME': '/Users/cltbld', 18:59:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:59:18 INFO - 'LOGNAME': 'cltbld', 18:59:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:59:18 INFO - 'MOZ_NO_REMOTE': '1', 18:59:18 INFO - 'NO_EM_RESTART': '1', 18:59:18 INFO - 'PAGER': '/bin/cat', 18:59:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:59:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:59:18 INFO - 'PWD': '/builds/slave/test', 18:59:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:59:18 INFO - 'SHELL': '/bin/bash', 18:59:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.V1um4lEnxM/Listeners', 18:59:18 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 18:59:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:59:18 INFO - 'USER': 'cltbld', 18:59:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:59:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:59:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:59:18 INFO - 'XPC_FLAGS': '0x0', 18:59:18 INFO - 'XPC_SERVICE_NAME': '0', 18:59:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:59:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:59:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:59:18 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-rSFpYo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:59:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:59:18 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-CokvpH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:59:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:59:18 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-S8F7Mv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:59:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:59:18 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-Q_HVkt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:59:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:59:19 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-aIulnJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:59:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:59:19 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-VrqGjr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:59:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:59:19 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-y6Z6ql-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:59:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:59:19 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-bLq7zW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:59:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:59:19 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-JMU_6a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:59:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:59:19 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-h_3Dbu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:59:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:59:19 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-Fu9lcg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:59:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:59:19 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-HKR8dK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:59:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:59:19 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-yuLAgc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:59:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:59:19 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-CrfHub-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:59:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:59:20 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-ynRC6b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:59:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:59:20 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-ieKidd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:59:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:59:20 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-Ndo2Nh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:59:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:59:20 INFO - Running setup.py install for manifestparser 18:59:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:59:20 INFO - Running setup.py install for mozcrash 18:59:20 INFO - Running setup.py install for mozdebug 18:59:20 INFO - Running setup.py install for mozdevice 18:59:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:59:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:59:20 INFO - Running setup.py install for mozfile 18:59:21 INFO - Running setup.py install for mozhttpd 18:59:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:59:21 INFO - Running setup.py install for mozinfo 18:59:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:59:21 INFO - Running setup.py install for mozInstall 18:59:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:59:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:59:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:59:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:59:21 INFO - Running setup.py install for mozleak 18:59:21 INFO - Running setup.py install for mozlog 18:59:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:59:21 INFO - Running setup.py install for moznetwork 18:59:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:59:22 INFO - Running setup.py install for mozprocess 18:59:22 INFO - Running setup.py install for mozprofile 18:59:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:59:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:59:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:59:22 INFO - Running setup.py install for mozrunner 18:59:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:59:22 INFO - Running setup.py install for mozscreenshot 18:59:22 INFO - Running setup.py install for moztest 18:59:22 INFO - Running setup.py install for mozversion 18:59:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:59:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:59:22 INFO - Cleaning up... 18:59:22 INFO - Return code: 0 18:59:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:59:22 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:59:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:59:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:22 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:59:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:59:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:22 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 0x104441b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104444768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe0b2486110>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10421fd30>, '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 0x104146db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104214be8>, '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.QNtLpvW9Jc/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.V1um4lEnxM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 18:59:22 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 18:59:22 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 18:59:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QNtLpvW9Jc/Render', 18:59:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:59:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:59:22 INFO - 'HOME': '/Users/cltbld', 18:59:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:59:22 INFO - 'LOGNAME': 'cltbld', 18:59:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:59:22 INFO - 'MOZ_NO_REMOTE': '1', 18:59:22 INFO - 'NO_EM_RESTART': '1', 18:59:22 INFO - 'PAGER': '/bin/cat', 18:59:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:59:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:59:22 INFO - 'PWD': '/builds/slave/test', 18:59:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:59:22 INFO - 'SHELL': '/bin/bash', 18:59:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.V1um4lEnxM/Listeners', 18:59:22 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 18:59:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:59:22 INFO - 'USER': 'cltbld', 18:59:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:59:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:59:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:59:22 INFO - 'XPC_FLAGS': '0x0', 18:59:22 INFO - 'XPC_SERVICE_NAME': '0', 18:59:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:59:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:59:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:59:23 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-OaMG3w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:59:23 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)) 18:59:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:59:23 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-_BOZKR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:59:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 18:59:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:59:23 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-6vtXKD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:59:23 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)) 18:59:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:59:23 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-BDTUIB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:59:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 18:59:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:59:23 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-8GTebw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:59:23 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)) 18:59:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:59:23 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-etrFCd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:59:23 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)) 18:59:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:59:23 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-0vgLFH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:59:23 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)) 18:59:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:59:23 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-BQxtw8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:59:24 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)) 18:59:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:59:24 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-WzIsaY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:59:24 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)) 18:59:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:59:24 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-434mo7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:59:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 18:59:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:59:24 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-Pdk_AD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:59:24 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)) 18:59:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:59:24 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-ZwTKFj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:59:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 18:59:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:59:24 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-LinWcV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:59:24 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)) 18:59:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:59:24 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-JA0Pku-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:59:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 18:59:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:59:24 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-PekrkN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:59:24 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)) 18:59:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:59:24 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-VHIFKE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:59:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 18:59:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:59:24 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-7fxF2b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:59:25 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)) 18:59:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:59:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:59:25 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)) 18:59:25 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:59:25 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:59:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:59:25 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 18:59:25 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 18:59:25 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 18:59:25 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 18:59:25 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 18:59:25 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 18:59:28 INFO - Downloading blessings-1.6.tar.gz 18:59:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:59:28 INFO - Installing collected packages: blessings 18:59:28 INFO - Running setup.py install for blessings 18:59:28 INFO - Successfully installed blessings 18:59:28 INFO - Cleaning up... 18:59:28 INFO - Return code: 0 18:59:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:59:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:59:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:59:28 INFO - Reading from file tmpfile_stdout 18:59:28 INFO - Current package versions: 18:59:28 INFO - blessings == 1.6 18:59:28 INFO - blobuploader == 1.2.4 18:59:28 INFO - docopt == 0.6.1 18:59:28 INFO - functools32 == 3.2.3-2 18:59:28 INFO - jsonschema == 2.5.1 18:59:28 INFO - manifestparser == 1.1 18:59:28 INFO - mozInstall == 1.12 18:59:28 INFO - mozcrash == 1.0 18:59:28 INFO - mozdebug == 0.1 18:59:28 INFO - mozdevice == 0.49 18:59:28 INFO - mozfile == 1.2 18:59:28 INFO - mozhttpd == 0.7 18:59:28 INFO - mozinfo == 0.9 18:59:28 INFO - mozleak == 0.1 18:59:28 INFO - mozlog == 3.4 18:59:28 INFO - moznetwork == 0.27 18:59:28 INFO - mozprocess == 0.24 18:59:28 INFO - mozprofile == 0.28 18:59:28 INFO - mozrunner == 6.13 18:59:28 INFO - mozscreenshot == 0.1 18:59:28 INFO - mozsystemmonitor == 0.3 18:59:28 INFO - moztest == 0.8 18:59:28 INFO - mozversion == 1.4 18:59:28 INFO - psutil == 3.1.1 18:59:28 INFO - requests == 1.2.3 18:59:28 INFO - wsgiref == 0.1.2 18:59:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:59: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:59:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:59:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:59:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:59:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:29 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 0x104441b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104444768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe0b2486110>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10421fd30>, '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 0x104146db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104214be8>, '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.QNtLpvW9Jc/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.V1um4lEnxM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 18:59:29 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 18:59:29 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 18:59:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QNtLpvW9Jc/Render', 18:59:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:59:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:59:29 INFO - 'HOME': '/Users/cltbld', 18:59:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:59:29 INFO - 'LOGNAME': 'cltbld', 18:59:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:59:29 INFO - 'MOZ_NO_REMOTE': '1', 18:59:29 INFO - 'NO_EM_RESTART': '1', 18:59:29 INFO - 'PAGER': '/bin/cat', 18:59:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:59:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:59:29 INFO - 'PWD': '/builds/slave/test', 18:59:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:59:29 INFO - 'SHELL': '/bin/bash', 18:59:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.V1um4lEnxM/Listeners', 18:59:29 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 18:59:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:59:29 INFO - 'USER': 'cltbld', 18:59:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:59:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:59:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:59:29 INFO - 'XPC_FLAGS': '0x0', 18:59:29 INFO - 'XPC_SERVICE_NAME': '0', 18:59:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:59:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:59:29 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)) 18:59:29 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)) 18:59:29 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)) 18:59:29 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)) 18:59:29 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)) 18:59:29 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)) 18:59:29 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)) 18:59:29 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)) 18:59:29 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)) 18:59:29 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)) 18:59:29 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)) 18:59:29 INFO - Cleaning up... 18:59:29 INFO - Return code: 0 18:59:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:59: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:59:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:59:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:59:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:59:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:29 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 0x104441b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104444768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe0b2486110>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10421fd30>, '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 0x104146db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104214be8>, '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.QNtLpvW9Jc/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.V1um4lEnxM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 18:59:29 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 18:59:29 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 18:59:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QNtLpvW9Jc/Render', 18:59:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:59:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:59:29 INFO - 'HOME': '/Users/cltbld', 18:59:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:59:29 INFO - 'LOGNAME': 'cltbld', 18:59:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:59:29 INFO - 'MOZ_NO_REMOTE': '1', 18:59:29 INFO - 'NO_EM_RESTART': '1', 18:59:29 INFO - 'PAGER': '/bin/cat', 18:59:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:59:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:59:29 INFO - 'PWD': '/builds/slave/test', 18:59:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:59:29 INFO - 'SHELL': '/bin/bash', 18:59:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.V1um4lEnxM/Listeners', 18:59:29 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 18:59:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:59:29 INFO - 'USER': 'cltbld', 18:59:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:59:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:59:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:59:29 INFO - 'XPC_FLAGS': '0x0', 18:59:29 INFO - 'XPC_SERVICE_NAME': '0', 18:59:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:59:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:59:29 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:59:29 INFO - Cleaning up... 18:59:29 INFO - Return code: 0 18:59:29 INFO - Running post-action listener: _resource_record_post_action 18:59:29 INFO - Running post-action listener: _start_resource_monitoring 18:59:29 INFO - Starting resource monitoring. 18:59:29 INFO - [mozharness: 2017-01-25 02:59:29.707295Z] Finished create-virtualenv step (success) 18:59:29 INFO - [mozharness: 2017-01-25 02:59:29.708329Z] Running install step. 18:59:29 INFO - Running pre-action listener: _resource_record_pre_action 18:59:29 INFO - Running main action method: install 18:59:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:59:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:59:29 INFO - Reading from file tmpfile_stdout 18:59:29 INFO - Detecting whether we're running mozinstall >=1.0... 18:59:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:59:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:59:30 INFO - Reading from file tmpfile_stdout 18:59:30 INFO - Output received: 18:59:30 INFO - Usage: mozinstall [options] installer 18:59:30 INFO - Options: 18:59:30 INFO - -h, --help show this help message and exit 18:59:30 INFO - -d DEST, --destination=DEST 18:59:30 INFO - Directory to install application into. [default: 18:59:30 INFO - "/builds/slave/test"] 18:59:30 INFO - --app=APP Application being installed. [default: firefox] 18:59:30 INFO - mkdir: /builds/slave/test/build/application 18:59:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 18:59:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 18:59:52 INFO - Reading from file tmpfile_stdout 18:59:52 INFO - Output received: 18:59:52 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 18:59:52 INFO - Running post-action listener: _resource_record_post_action 18:59:52 INFO - [mozharness: 2017-01-25 02:59:52.074778Z] Finished install step (success) 18:59:52 INFO - [mozharness: 2017-01-25 02:59:52.074923Z] Running run-tests step. 18:59:52 INFO - Running pre-action listener: _resource_record_pre_action 18:59:52 INFO - Running main action method: run_tests 18:59:52 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:59:52 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:59:52 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:59:52 INFO - 2017-01-24 18:59:52.089 screenresolution[1622:7316] starting screenresolution argv=screenresolution get 18:59:52 INFO - 2017-01-24 18:59:52.091 screenresolution[1622:7316] Display 0: 1600x1200x32@60 18:59:52 INFO - 2017-01-24 18:59:52.097 screenresolution[1623:7318] starting screenresolution argv=screenresolution list 18:59:52 INFO - Available Modes on Display 0 18:59:52 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:59:52 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:59:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:59:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:59:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:59:52 INFO - Intel Iris: 18:59:52 INFO - Chipset Model: Intel Iris 18:59:52 INFO - Type: GPU 18:59:52 INFO - Bus: Built-In 18:59:52 INFO - VRAM (Dynamic, Max): 1536 MB 18:59:52 INFO - Vendor: Intel (0x8086) 18:59:52 INFO - Device ID: 0x0a2e 18:59:52 INFO - Revision ID: 0x0009 18:59:52 INFO - Displays: 18:59:52 INFO - Display: 18:59:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:59:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:59:52 INFO - Display Serial Number: 1600x1200 60 18:59:52 INFO - Main Display: Yes 18:59:52 INFO - Mirror: Off 18:59:52 INFO - Online: Yes 18:59:52 INFO - Rotation: Supported 18:59:52 INFO - Return code: 0 18:59:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:59:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:59:52 INFO - Python 2.7.3 18:59:52 INFO - Return code: 0 18:59:52 INFO - grabbing minidump binary from tooltool 18:59:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:59:52 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10421fd30>, '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 0x104146db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104214be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:59:52 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 18:59:52 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 18:59:52 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 18:59:52 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:59:52 INFO - Return code: 0 18:59:52 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 18:59:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:59:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:59:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 18:59:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:59:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GcbUBbm3Q2OUSE5H79AZ6Q/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0126', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 18:59:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GcbUBbm3Q2OUSE5H79AZ6Q/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0126 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 18:59:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QNtLpvW9Jc/Render', 18:59:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:59:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:59:52 INFO - 'HOME': '/Users/cltbld', 18:59:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:59:52 INFO - 'LOGNAME': 'cltbld', 18:59:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:59:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 18:59:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:59:52 INFO - 'MOZ_NO_REMOTE': '1', 18:59:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:59:52 INFO - 'NO_EM_RESTART': '1', 18:59:52 INFO - 'PAGER': '/bin/cat', 18:59:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:59:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:59:52 INFO - 'PWD': '/builds/slave/test', 18:59:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:59:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:59:52 INFO - 'SHELL': '/bin/bash', 18:59:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.V1um4lEnxM/Listeners', 18:59:52 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 18:59:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:59:52 INFO - 'USER': 'cltbld', 18:59:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:59:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:59:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:59:52 INFO - 'XPC_FLAGS': '0x0', 18:59:52 INFO - 'XPC_SERVICE_NAME': '0', 18:59:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:59:52 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GcbUBbm3Q2OUSE5H79AZ6Q/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0126', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 18:59:52 INFO - mozversion application_buildid: 20170117083128 18:59:52 INFO - mozversion application_changeset: 6a23526fe5168087d7e4132c0705aefcaed5f571 18:59:52 INFO - mozversion application_display_name: Nightly 18:59:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:59:52 INFO - mozversion application_name: Firefox 18:59:52 INFO - mozversion application_remotingname: firefox 18:59:52 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:59:52 INFO - mozversion application_vendor: Mozilla 18:59:52 INFO - mozversion application_version: 53.0a1 18:59:52 INFO - mozversion platform_buildid: 20170117083128 18:59:52 INFO - mozversion platform_changeset: 6a23526fe5168087d7e4132c0705aefcaed5f571 18:59:52 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:59:52 INFO - mozversion platform_version: 53.0a1 18:59:52 INFO - using testdate: 1485313192 18:59:52 INFO - actual date: 1485313192 18:59:52 INFO - starting webserver on 'localhost:49236' 18:59:52 INFO - SUITE-START | Running 2 tests 18:59:52 INFO - TEST-START | dromaeo_css 18:59:52 INFO - operating with platform_type : mac_ 18:59:52 INFO - Initialising browser for dromaeo_css test... 18:59:52 INFO - TEST-INFO | started process 1633 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/tmp52iCNB/profile http://localhost:49236/getInfo.html) 18:59:55 INFO - PROCESS | 1633 | __metrics Screen width/height:1600/1200 18:59:55 INFO - PROCESS | 1633 | colorDepth:24 18:59:55 INFO - PROCESS | 1633 | Browser inner width/height: 1024/689 18:59:55 INFO - PROCESS | 1633 | __metrics 18:59:55 INFO - PROCESS | 1633 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 18:59:55 INFO - PROCESS | 1633 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:59:55 INFO - TEST-INFO | 1633: exit 0 18:59:55 INFO - Browser initialized. 18:59:55 INFO - Running cycle 1/1 for dromaeo_css test... 18:59:55 INFO - TEST-INFO | started process 1635 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/tmp52iCNB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:00:07 INFO - PROCESS | 1635 | RSS: Main: 235286528 19:00:07 INFO - PROCESS | 1635 | 19:03:11 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49236/tests/dromaeo/cssquery-ext.html) 19:03:13 INFO - PROCESS | 1635 | RSS: Main: 409387008 19:03:13 INFO - PROCESS | 1635 | 19:04:58 INFO - PROCESS | 1635 | ************************* 19:04:58 INFO - PROCESS | 1635 | A coding exception was thrown and uncaught in a Task. 19:04:58 INFO - PROCESS | 1635 | 19:04:58 ERROR - PROCESS | 1635 | Full message: TypeError: NetworkError when attempting to fetch resource. 19:04:58 INFO - PROCESS | 1635 | Full stack: 19:04:58 INFO - PROCESS | 1635 | ************************* 19:06:16 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-ext.html (next: http://localhost:49236/tests/dromaeo/cssquery-jquery.html) 19:06:16 INFO - PROCESS | 1635 | RSS: Main: 368136192 19:06:16 INFO - PROCESS | 1635 | 19:09:19 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49236/tests/dromaeo/cssquery-mootools.html) 19:09:19 INFO - PROCESS | 1635 | RSS: Main: 335618048 19:09:19 INFO - PROCESS | 1635 | 19:12:22 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49236/tests/dromaeo/cssquery-prototype.html) 19:12:22 INFO - PROCESS | 1635 | RSS: Main: 339144704 19:12:22 INFO - PROCESS | 1635 | 19:15:26 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49236/tests/dromaeo/cssquery-yui.html) 19:15:26 INFO - PROCESS | 1635 | RSS: Main: 323551232 19:15:26 INFO - PROCESS | 1635 | 19:18:29 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-yui.html (next: http://localhost:49236/tests/dromaeo/cssquery-dojo.html) 19:18:30 INFO - PROCESS | 1635 | RSS: Main: 574881792 19:18:30 INFO - PROCESS | 1635 | 19:18:30 INFO - PROCESS | 1635 | __start_tp_report 19:18:30 INFO - PROCESS | 1635 | _x_x_mozilla_page_load 19:18:30 INFO - PROCESS | 1635 | _x_x_mozilla_page_load_details 19:18:30 INFO - PROCESS | 1635 | |i|pagename|runs| 19:18:30 INFO - PROCESS | 1635 | |0;dojo.html;3224.113368823573;3226.7418606511483;3287.621923478799;3295.4562497187967;3301.9009429717107;5531.889362212753;5562.3881373048935;5578.804741834037;5590.944090559094;5610.943890561093;5458.781648734046;5532.889342213153;5599.216109744639;5609.102543593026;5653.293338332708;5052.696838189702;5064.088464076464;5066.417362003362;5100.719460429675;5103.489651034885;5135.255387968742;5212.8436146915465;5220.738963051851;5223.399309079467;5251.474852514756;5059.747012649353;5092.490750924915;5178.896422071575;5190.71451070191;5223.843284701465;5043.445221025684;5102.591792656615;5105.387353517602;5115.462876397999;5169.948300516984;5050.964552266776;5090.720010399426;5099.923501147486;5100.209467532539;5150.793968241266;5626.184203290541;5631.943680563224;5634.943650563524;5642.633228840113;5652.09566469367;6018.458338749533;6061.333253342129;6066.150738896514;6129.511613758974;6172.444479996821;5775.913361299584;6229.470495007885;6251.718672659741;6260.467860231885;6267.811965641038;5777.653340799566;5778.24882765242;5785.913211301834;5786.189933409326;5794.391588883149;6178.505719542426;6179.28938172107;6209.875802483925;6228.22147231596;6269.216347956505;6056.273247210275;6066.696665166724;6075.27096748393;6094.634321940698;6122.2959359674205;6098.176746139215;6171.105189747551;6176.69116544171;6180.536459765535;6180.690965451709;6067.696615169312;6102.938970610237;6104.4200800923845;6127.220070483952;6130.245269656939;6154.846128846725;6178.474829639441;6180.227471566054;6181.8454538636;6190.040543715641;4077.1641813428178;4945.901081978413;4948.455669876311;4965.354503914468;4969.453360130383;4345.826166953287;4401.515833258339;4425.09285596452;4425.468943726709;4441.4892287387365;4844.346013288161;5782.3639399666;5841.50347220491;5846.678432686158;5850.9175802476675;6166.290876549254;6180.473417077209;6207.81376558704;6214.502839772807;6247;5740.827775166668;5782.88434231313;5804.1293805929445;5808.912866307009;5822.184894114827;5276.947230527646;5342.652727572773;5345.3852806926925;5346.91979620306;5372.91940620891;6207.6275423474735;6224.221972253377;6233;6235.189425374672;6235.719392627252;6119.258838874149;6137.867325793252;6150.323464418821;6151.815445536641;6198.752049917953;6265.185525881606;6270.529710271657;6278.246610406781;6280.497560195082;6304.369563043659;6040.456358927718;6109.083637454418;6119.755209791559;6120.296165940974;6123.755049797958;5944.851378715393;6090.390960904051;6146.631202127886;6214.285357183981;6220.409061139185;5975.760969561169;6054.939450605614;6055.1522786810765;6077.756889724362;6105.603135796159;5858;6028;6052.515798736003;6054.182685337423;6097.542684298606;5664.37691853904;5847.06446968483;5862.94137058641;5876.764929402776;5897.764089436375;5876.147958545901;5927.377625349276;6024.397560244116;6053.394660534088;6060.515158787198;5892.705364731832;5899.321578018583;5917.378675239038;5920.200772895776;5921.052631578927 19:18:30 INFO - PROCESS | 1635 | |1;ext.html;437.4269706684246;450.34474839109095;487.0721275969279;497.18461722774657;519.6154845414394;30071.398572028545;31380.686193138063;39176.02059948499;40736;40836.77489675307;41135;41400.58599414005;41459.585404145946;41507.79246103765;41599.792001039954;9184.586693598787;9387.530623468834;9402.200812930909;9404.952975235114;9407.20038796703;8304.750857474286;8490;9372.109649583314;10963.890361096406;11221.38282394468;11051.060659843923;11074.778504429907;11080.889191108066;11115.610953616626;11178.608748693798;9446.385984910994;11161.49773260197;11167.609133680364;11169.106471482262;11178.04986576142;7269.3094156055095;8216.83566328676;8428.662853485854;8519.872201916976;9134.72113904054;37796.05509862275;39430.21139577193;39462.80268598639;39495.21009579821;39529.80235098835;3984.7609143451195;4009.959900400988;4040.616141466556;4054.5337286212166;4070.043539768152;23485.41286467835;29552.852235738897;29913.03657229084;30235.244118897204;30371.848140759375;3149.7952633078776;3173.1749745066218;3218.1311046017677;3308.983455082709;3312.801231926092;479355;483505;484169;485565;486251.56874215754;58090.90045545157;58432.12351814726;58432.70783646055;58481.41518584845;58540.707296463246;61793.69103154545;61794.38205617976;61796;61881;61997;15420.537383878502;15685.843141568666;15695.215239237992;15701.450449234451;15702.921485392728;11038.779224415466;11971.98238149767;12039.879601203877;12042.81935770964;12106.213096148722;13646.454141834216;13988.440462381594;15464.304106315243;15666.13836238995;15817.971831830893;6622.96688516564;6644.435223006002;6669.599824010478;6781.3046738315425;6801.897971530431;854.3293514591016;875.4286056528547;892.5581836990731;898.1063841477771;913.5386629751932;28680;28895;29673.554896676567;29749.702502975128;30068.04811442785;1045.749020235138;1059.9099076578423;1080.7784404197278;1084.1706094837455;1212.4665147335145;14497.855021449861;14593.905457090548;15475.226238688021;15584.44145624764;15816.367345306058;229646.70353296588;229909;230030.8498457497;230212;230302;59423.702881486184;59428.10857837049;59452.10821837589;59652.403475965555;59670;1432.1407155706493;1443.314425647809;1458.0814087125254;1458.7301349250422;1462.3784891421317;27855.860720696266;28340.574891376233;29348.706512934597;29379.265518362212;29481.557776633796;50995;51347;51496.48503514917;51506.48493515017;51650;542492;544759;550537;550557;552229;24166.87916560406;24517;24522.87738561296;24539.89570469369;24593;42123;43407.34888976605;43466.13067738691;45328.09343813171;45635;33825;34225.65774342225;35528.289434211685;36540.63459365479;36686;35425.82287088651;35762.8211858939;35818.82090589531;36827.63172368242;36989.630103699696;35156.824215878754;35821;36015;36082.09794755152;36113;29764.85117574398;31674.36651267008;31789.364212715154;32067.198320042186;32125.67874321227;23540.882295588413;23833.165839195546;23913;23929.52140957206;23953.880230598734 19:18:30 INFO - PROCESS | 1635 | |2;jquery.html;366.3095065800964;382.1363717997325;386.31429213146663;393.6830851164812;412.40613516536183;15504;15532.767008494868;18765.155567999438;20928.790712092876;21031;21917.561648767016;22105.889470552625;22607.886960565214;22755.089796408167;22900.541989160207;5756.251687280647;5910.704464776754;6039.818805435844;6111.786087486938;6158.753649854;3749.343864823659;5996.7601295948325;6042.969785151068;6052.697365131726;6054.909176362358;4124.175164967019;5081.237814327844;6626.2711101779005;6686.498512611549;6749.19009718832;6017.2779266488305;6121.693915304217;6233.937660623381;6747.359000894907;6763.323667633246;5953.3748956359395;5958.016927207049;5962.463378295931;5968.373320801296;5973.342932277446;12974.351282435935;15434.073955562702;24872.253832385057;24906.875465622736;25509.23472295834;2528.2036158610163;2574.1505303249883;2629.2585968984863;2648.1261183809297;2761.502929472694;9834.606615735362;10423.530941107669;10425.739356516073;11045.779084418267;12326.753464930742;1825.6896327624336;1828.277830257041;1859.4049904030715;1866.7013277875474;1871.8023789556232;115665;118686.40656796747;119020;120713;123450.38274808659;9828.754281142885;9960.452175130293;11498.252613580258;11515.251508652078;11670.70823229426;15552.533423997298;15571.143587102591;15578.610534736723;15590.610234743996;15611.921940390226;6841.315868413119;8455.069942306342;8617.655293788179;8677.305815534743;8724.65101395937;7062.71749130029;8335.291500222427;8342.081528248083;8367.539785311745;8493.0465992822;4468.821247150143;4702.764861756898;4709.081729062868;4715.976420117878;4801.351817504592;1741.4340339389748;1996.9500762481055;1998.2007197120977;2002.9399118026483;2004.5088953206557;986.5166068626321;1003.6136087606324;1017.3539802225492;1039.2725092435326;1073.8872418396113;18047.458576242472;19564.804351956584;21739.34781956544;21956.011979460964;22130.889345553493;1027.7944411117805;1047.5443182215608;1069.641670040545;1082.5994382078682;1084.208527774713;10076.848847267296;11480;11485.425728713699;11494;11510.366929818772;735244;744640;746022;752405;757222;112973;129543.35228323798;135048.3247583756;156850;159786;1041.8801837788599;1058.3596923860953;1093.049047328813;1095.9452027398759;1097.8188598881095;18673.879567225467;19590.60818783588;20204.29284975019;20206.19175232974;20705.720385482455;47340.289895652284;54702;61408.692956534935;63337.68331158315;63441;81413.77879331933;82389;86515.56742216248;87717.56141219253;89420;7244.927550724426;7512.9624351880075;7584.241575842371;7978.800529986796;8470.788230294293;10837.78324433491;12890.904273136513;13081.672958176121;13175.868241317847;13550.390232439368;11307.265027773168;11630.011449026928;11636.301821890713;11742.356070150357;11885.762284754084;11438.084953203557;11509.482073306554;11640.650780476599;11719.824202637137;11877.346745929057;11418;11519.366434846164;11748.530058797553;12032.639020829389;12056.156069075081;7443.627818609156;7521.172671006294;7638;7663.160841398136;7786.5717385542075;10382;11291.096712263163;11586.536538538701;11712.70718232051;11827.763444730885 19:18:30 INFO - PROCESS | 1635 | |3;mootools.html;1300.2653500772067;1447.610294117647;1473.646324882028;1475.041223204916;1485.2796393749034;7979.441439099265;8413.242808147266;8438.240558349748;8447.23974842264;8448.78878028048;7398.482106252564;7682.308592226698;7689.961855149553;7982.600869956494;8074.354051675867;2256.593813113639;2293.5068960173558;2297.597920363938;2302.769723027692;2308.4459729664845;2218.4232099654128;2313.201945328867;2321.791038806507;2325.046730840356;2326.7673232676766;2057.9897100514477;2125.564259326842;2133.296012315932;2240.764719704432;2312.3294244669028;2312.7918487336137;2332.7783860533223;2336.9649455258186;2341.4497593065616;2346.389938615955;2009.3770931011288;2272.8068114210314;2355.0462062864567;2358.9410264743346;2360.0205914545445;7164.785056448315;8377.413581049268;8427.831443371098;8467.49195048299;8469.32245420365;5020.297158397827;5184.196449550326;5192.7403629818355;5197;5203.063448579254;3048.542718592229;3390.440577304742;3398.762086653935;3536.204354020325;3600.225951420457;1209.8911098001222;1233.0690328801786;1269.0799170601333;1282.4805953588718;1290.3999640167274;10827.729306767395;10903.34579925207;10910.454477276184;10915.345079295268;10920.12638988879;3844.884653460401;4127.236461254677;4392.3191905254735;4689.718616882929;4706.576408123286;9458.57436415363;9468.195203407788;9476.620935162655;9485.004074572209;9493.857592136124;5220.791168353223;5225.033368826703;5232.2674825524455;5246.422893481714;5248.606354523426;3925.371940489508;4628.699134556243;4765.737884416321;4771.974025584516;4777.211760059621;3646.4165733482514;3688.61269566697;3715.2569486102348;3739.3456145174487;3741.9251614967548;1166.9941650291694;1168.5617893290016;1177.8233265010147;1178.3577950017261;1179.0626451970704;720.6648908257686;771.4792515052317;775.1163673412202;781.3631890009624;790.5414859381544;5299.761510732026;5316.016536940679;5357.330333708286;5398.9472052949295;5491.7254137292975;588.6762280745659;663.5985228936424;677.9796606101825;974.8245315843217;994.9701508954598;3118.875244990175;3564.9643503564635;3629.94555081674;3640.308341415123;3729.5524537055726;9487.66793162236;9719.61121555144;9719.659811906691;9853.310268281295;9967.601295948081;9923.900760992443;9926.900730992742;9928.220098372323;9928.80142397148;9967.40195588267;7453.217412171753;7707.576083315472;7756.689732410753;7761.728339508203;7773.883391749128;5165.690058596496;5253.868653283698;5414.512693857571;5446.836594902159;5678.403767604342;8708.346873984603;8889.19997200255;8956.149165829236;9219.953900230455;9263.629454822001;8901.243394311556;9067.183953444222;9251.491167985825;9362.95318523403;9401;7647.617619118911;7871.527708337518;7875.291223789886;7875.409344299086;7887.44787864844;7614.010178676736;7791.220877912164;7851.9214807851195;7893.763187104396;7899.973003509507;7123.857522849617;7141.250168732416;7157.928420715934;7199.424046076197;7205.459590530626;7031.613261270679;7119.466040046914;7137.017456062476;7182.245864184394;7242.311980361857;5783.421657834183;6236.03341482071;6284.937150628435;6290.591111577733;6415.8396040097505;4711.081339138835;4838.225883858566;4896.804127834846;4899.265110233351;5073.467285934924;4853.223484242645;4877.048975449895;4973.104841128632;4990.72551009698;5064.9746751267485 19:18:30 INFO - PROCESS | 1635 | |4;prototype.html;298.24543903923075;354.2510121457489;365.53576957264266;371.96466335698096;373.14177391998396;4450.465944086714;4810.518948105192;5152.974235128819;5196.636235463514;5251.555822148911;4155.792210389476;4617.8152873885;4627.305904114384;4949.406071271444;5072;4072.165206132736;4084.1219137885423;4099.303118469852;4102.2821006323775;4119.505659320886;3268.509723541476;3598.784072955631;4103.38449232616;4104.79476026199;4109.794510274489;2906.564015397686;3372.797632142067;3992.8420757980152;4046.858359957402;4084.0810817565957;3228.564143840575;3390.5253264542985;4023.959760402388;4045.8381664733374;4047.955782329934;3471.4272145096284;3570.875329179134;3587.605363410049;3620.3845346291196;3625.8912232633065;4281.93216444376;4755.9286610700865;5007.824726134568;5033.1814184056675;5074.908894587645;4658;4661.557152070548;4672.322513235596;4677.228257337535;4698.882527936795;5272.92090618641;5432.945670543283;5439.673619582838;5449.536789372908;5458.536024437927;3825.5791862895057;3900.395438707005;3948.1314110895555;3990.1221731219084;3992.800359982018;4818.855609253884;5207.609429292818;5257.526822585909;5716.857078573027;5740.999999999958;3804.6575808176844;3865.40086286626;4055.6755459563165;4060.878173654795;4068.1253530490494;3503.7547371683736;3648.3432982062955;4000.0592455084475;4020.4974378202724;4143.150654115899;4518.593326600556;4558.156741002925;4560.612347950395;4611.400517932714;4632.930506042345;4595.736172552508;5507;5510.173473978855;5510.366307874646;5514.779408823602;1266.7086570088932;1278.6355888571713;1295.2487557216791;1303.843538775334;1326.2440408966988;842.4987132656059;918.554501066982;942.9528523573794;951.986548450037;952.4808979106404;4662.254039353687;4874.195757699939;4926.507349265116;4930.457649658535;4950.628702847301;4700.694454860423;4828.447285621563;4972.825951091694;5320.76056577455;5367.651102678314;4573.118935070884;4784.545468180518;4866.586340161055;4884.3650325457465;4928.482509336468;2166.512534679716;2433.841800282976;2550.7576780206223;2571.251548946734;2626.439221758808;4271.002926575914;5075.847724568195;5315.066850530657;5428.4028756836715;5482.616216864782;4697.647676424282;4771.308160316735;4817.518248175154;4978.651494395358;5286.3392075990505;4848.781804818721;4971.527704868032;5244.790208391774;5530.1243353455975;5551.916721249185;5049.147231814013;5052.69683818972;5231.372235331784;5277.2875661785165;5366.517013468807;4467.486239082417;4478.910421791611;5223.884326847633;5232.738363081907;5242.292290540729;4920;5450.040463178489;5469.5696485845;5496.835094947158;5520.889582208413;3407.352603005421;3619.6380361963593;3627.9274414511033;3648.744587878823;3913.8630147944687;4722.409698787652;4872.220444728827;5174.508421699932;5209.723617713685;5252.789888404421;4216.957830421657;4259.42497762798;4575.58819706228;4693.389859318267;5100.948990510047;4782.962818610138;4890.793917231107;5093.567046801063;5131.769070391916;5153.742312884416;4505.301678239878;5010.849674509771;5064.316317297118;5109.952459745818;5189.948100519097;4593.862184134481;4784.449788274393;5198.6880787152895;5336.504589493888;5414.593905457185;4892.657513973988;4971.09191123197;5014.5737612303365;5270.446603106772;5274.868128296824 19:18:30 INFO - PROCESS | 1635 | |5;yui.html;725.7278520554792;759.4304271796153;772.7025095338294;823.1315961660449;830.1698301698302;14674.486392976249;15583.142927139002;15584.064956102613;15592.45426410076;15612;12122.393880305972;14257.92871035646;14457.855421445782;14462.855371446283;14477.565673029825;664.5979182594521;685.568092101975;687.9621620810854;843.2115971566604;862.5816479007676;834.2866848844242;845.3490812074699;859.9699010534632;861.1646702698373;863.1497974495118;923.6213152607432;925.4724806860092;925.759302581327;926.0831776541243;927.2628260532858;690.6408667492875;712.6365553567666;886.3795343259744;917.8302014127407;918.7932715139107;686.800827759949;692.0933577014127;692.7506097804786;693.237438817302;693.448708276921;15032.473863414838;15325.616859578487;15332.540023799304;15346.923265383602;15364;13859;13941.512047078304;13945.302734863319;14013.207256537798;14017.775911540402;12514.74970500594;12572.559960401433;12658.240505569695;12734.490620375174;13202.537911173158;4397.802098905557;4421.358902959085;4537.296719008559;4643.744594047326;4653.115907977473;101946;102717;103005.4849725754;103537.4823125887;104222.47888760583;10209.795804083877;10585.364878107184;10611.84082238767;11108.444577771079;11331.830022549668;20838.68741968872;21327.46681332979;21343.039563219692;21588.676169857466;21734.45663858416;7475.364594009461;7493.70025198986;7527.774166775005;7668.194839541879;7678.96160519205;4147.896302592399;4186.581341865789;4186.602272784081;4213;4221.071364299849;3445.4831775233915;3491.965080349215;3518.894433167009;3530.735194860396;3542.5040494330815;640.065504363625;640.5420124610926;644.6357807838556;649.4998850884792;659.8090446743673;629.4523764325066;643.6041834271982;649.9740010399531;662.9635370054693;672.4687496877413;9283.48940808262;9626.566804493814;9769.706908792748;9971.05274998874;9979.602855600222;559.5914982063035;631.5358211714387;664.3821246241042;671.194566520168;683.3656255136377;4359.215341238608;4745.549172828576;4769.308450274691;4778.450478194983;4795.400574928134;76767;96584.55123173157;96899.51550242204;97777.51111244399;98370.50814745881;83817.74273385904;87158.56420717982;87373.56313218393;88219.95780758683;89150;57721;75226;75761.62119189369;76532.99999999888;77781;8487.702930397407;8639.23766144253;9033.77415564616;9078.636854525745;9426.717198484057;35679;47652.761736191096;48552.27171592358;48865.51134488752;49100;58449.415505844394;60016.39983600283;61267.693661531404;62061.795899600096;62924.05613915886;13050.934745326213;13272;13482.46070157222;13602.795958060438;13666.93166534161;14589.85410145885;14809;14947.252637368305;15476.458323958608;15490.289199390287;13678.247696376397;13754.793678095037;14012.369443374868;14096;14596.562103136923;13730.244836534086;13888.375023123781;13898;14122.43510259578;14236;12892.935535322264;13317.467301307839;13416.798748018982;13436.395362208528;13783.173009619455;10979;11109.333439993627;11355.886441135483;11399;11957.461914213707;8937.865932010895;9791.608335666493;10525;10750.408727519749;10760.62337818204 19:18:30 INFO - PROCESS | 1635 | __end_tp_report 19:18:30 INFO - PROCESS | 1635 | __start_cc_report 19:18:30 INFO - PROCESS | 1635 | _x_x_mozilla_cycle_collect,1886 19:18:30 INFO - PROCESS | 1635 | __end_cc_report 19:18:30 INFO - PROCESS | 1635 | __startTimestamp1485314310238__endTimestamp 19:18:30 INFO - PROCESS | 1635 | 19:18:30 INFO - PROCESS | 1635 | ------- Summary: start ------- 19:18:30 INFO - PROCESS | 1635 | Number of tests: 6 19:18:30 INFO - PROCESS | 1635 | 19:18:30 INFO - PROCESS | 1635 | [#0] dojo.html Cycles:165 Average:5675.84 Median:5892.71 stddev:648.20 (11.0%) stddev-sans-first:621.00 19:18:30 INFO - PROCESS | 1635 | Values: 3224.1 3226.7 3287.6 3295.5 3301.9 5531.9 5562.4 5578.8 5590.9 5610.9 5458.8 5532.9 5599.2 5609.1 5653.3 5052.7 5064.1 5066.4 5100.7 5103.5 5135.3 5212.8 5220.7 5223.4 5251.5 5059.7 5092.5 5178.9 5190.7 5223.8 5043.4 5102.6 5105.4 5115.5 5169.9 5051.0 5090.7 5099.9 5100.2 5150.8 5626.2 5631.9 5634.9 5642.6 5652.1 6018.5 6061.3 6066.2 6129.5 6172.4 5775.9 6229.5 6251.7 6260.5 6267.8 5777.7 5778.2 5785.9 5786.2 5794.4 6178.5 6179.3 6209.9 6228.2 6269.2 6056.3 6066.7 6075.3 6094.6 6122.3 6098.2 6171.1 6176.7 6180.5 6180.7 6067.7 6102.9 6104.4 6127.2 6130.2 6154.8 6178.5 6180.2 6181.8 6190.0 4077.2 4945.9 4948.5 4965.4 4969.5 4345.8 4401.5 4425.1 4425.5 4441.5 4844.3 5782.4 5841.5 5846.7 5850.9 6166.3 6180.5 6207.8 6214.5 6247.0 5740.8 5782.9 5804.1 5808.9 5822.2 5276.9 5342.7 5345.4 5346.9 5372.9 6207.6 6224.2 6233.0 6235.2 6235.7 6119.3 6137.9 6150.3 6151.8 6198.8 6265.2 6270.5 6278.2 6280.5 6304.4 6040.5 6109.1 6119.8 6120.3 6123.8 5944.9 6090.4 6146.6 6214.3 6220.4 5975.8 6054.9 6055.2 6077.8 6105.6 5858.0 6028.0 6052.5 6054.2 6097.5 5664.4 5847.1 5862.9 5876.8 5897.8 5876.1 5927.4 6024.4 6053.4 6060.5 5892.7 5899.3 5917.4 5920.2 5921.1 19:18:30 INFO - PROCESS | 1635 | 19:18:30 INFO - PROCESS | 1635 | [#1] ext.html Cycles:180 Average:57026.85 Median:35918.00 stddev:118205.51 (329.1%) stddev-sans-first:118460.75 19:18:30 INFO - PROCESS | 1635 | Values: 437.4 450.3 487.1 497.2 519.6 30071.4 31380.7 39176.0 40736.0 40836.8 41135.0 41400.6 41459.6 41507.8 41599.8 9184.6 9387.5 9402.2 9405.0 9407.2 8304.8 8490.0 9372.1 10963.9 11221.4 11051.1 11074.8 11080.9 11115.6 11178.6 9446.4 11161.5 11167.6 11169.1 11178.0 7269.3 8216.8 8428.7 8519.9 9134.7 37796.1 39430.2 39462.8 39495.2 39529.8 3984.8 4010.0 4040.6 4054.5 4070.0 23485.4 29552.9 29913.0 30235.2 30371.8 3149.8 3173.2 3218.1 3309.0 3312.8 479355.0 483505.0 484169.0 485565.0 486251.6 58090.9 58432.1 58432.7 58481.4 58540.7 61793.7 61794.4 61796.0 61881.0 61997.0 15420.5 15685.8 15695.2 15701.5 15702.9 11038.8 11972.0 12039.9 12042.8 12106.2 13646.5 13988.4 15464.3 15666.1 15818.0 6623.0 6644.4 6669.6 6781.3 6801.9 854.3 875.4 892.6 898.1 913.5 28680.0 28895.0 29673.6 29749.7 30068.0 1045.7 1059.9 1080.8 1084.2 1212.5 14497.9 14593.9 15475.2 15584.4 15816.4 229646.7 229909.0 230030.8 230212.0 230302.0 59423.7 59428.1 59452.1 59652.4 59670.0 1432.1 1443.3 1458.1 1458.7 1462.4 27855.9 28340.6 29348.7 29379.3 29481.6 50995.0 51347.0 51496.5 51506.5 51650.0 542492.0 544759.0 550537.0 550557.0 552229.0 24166.9 24517.0 24522.9 24539.9 24593.0 42123.0 43407.3 43466.1 45328.1 45635.0 33825.0 34225.7 35528.3 36540.6 36686.0 35425.8 35762.8 35818.8 36827.6 36989.6 35156.8 35821.0 36015.0 36082.1 36113.0 29764.9 31674.4 31789.4 32067.2 32125.7 23540.9 23833.2 23913.0 23929.5 23953.9 19:18:30 INFO - PROCESS | 1635 | 19:18:30 INFO - PROCESS | 1635 | [#2] jquery.html Cycles:180 Average:39857.75 Median:21828.45 stddev:123896.56 (567.6%) stddev-sans-first:124208.64 19:18:30 INFO - PROCESS | 1635 | Values: 366.3 382.1 386.3 393.7 412.4 15504.0 15532.8 18765.2 20928.8 21031.0 21917.6 22105.9 22607.9 22755.1 22900.5 5756.3 5910.7 6039.8 6111.8 6158.8 3749.3 5996.8 6043.0 6052.7 6054.9 4124.2 5081.2 6626.3 6686.5 6749.2 6017.3 6121.7 6233.9 6747.4 6763.3 5953.4 5958.0 5962.5 5968.4 5973.3 12974.4 15434.1 24872.3 24906.9 25509.2 2528.2 2574.2 2629.3 2648.1 2761.5 9834.6 10423.5 10425.7 11045.8 12326.8 1825.7 1828.3 1859.4 1866.7 1871.8 115665.0 118686.4 119020.0 120713.0 123450.4 9828.8 9960.5 11498.3 11515.3 11670.7 15552.5 15571.1 15578.6 15590.6 15611.9 6841.3 8455.1 8617.7 8677.3 8724.7 7062.7 8335.3 8342.1 8367.5 8493.0 4468.8 4702.8 4709.1 4716.0 4801.4 1741.4 1997.0 1998.2 2002.9 2004.5 986.5 1003.6 1017.4 1039.3 1073.9 18047.5 19564.8 21739.3 21956.0 22130.9 1027.8 1047.5 1069.6 1082.6 1084.2 10076.8 11480.0 11485.4 11494.0 11510.4 735244.0 744640.0 746022.0 752405.0 757222.0 112973.0 129543.4 135048.3 156850.0 159786.0 1041.9 1058.4 1093.0 1095.9 1097.8 18673.9 19590.6 20204.3 20206.2 20705.7 47340.3 54702.0 61408.7 63337.7 63441.0 81413.8 82389.0 86515.6 87717.6 89420.0 7244.9 7513.0 7584.2 7978.8 8470.8 10837.8 12890.9 13081.7 13175.9 13550.4 11307.3 11630.0 11636.3 11742.4 11885.8 11438.1 11509.5 11640.7 11719.8 11877.3 11418.0 11519.4 11748.5 12032.6 12056.2 7443.6 7521.2 7638.0 7663.2 7786.6 10382.0 11291.1 11586.5 11712.7 11827.8 19:18:30 INFO - PROCESS | 1635 | 19:18:30 INFO - PROCESS | 1635 | [#3] mootools.html Cycles:180 Average:5381.70 Median:5251.24 stddev:2968.89 (56.5%) stddev-sans-first:2961.37 19:18:30 INFO - PROCESS | 1635 | Values: 1300.3 1447.6 1473.6 1475.0 1485.3 7979.4 8413.2 8438.2 8447.2 8448.8 7398.5 7682.3 7690.0 7982.6 8074.4 2256.6 2293.5 2297.6 2302.8 2308.4 2218.4 2313.2 2321.8 2325.0 2326.8 2058.0 2125.6 2133.3 2240.8 2312.3 2312.8 2332.8 2337.0 2341.4 2346.4 2009.4 2272.8 2355.0 2358.9 2360.0 7164.8 8377.4 8427.8 8467.5 8469.3 5020.3 5184.2 5192.7 5197.0 5203.1 3048.5 3390.4 3398.8 3536.2 3600.2 1209.9 1233.1 1269.1 1282.5 1290.4 10827.7 10903.3 10910.5 10915.3 10920.1 3844.9 4127.2 4392.3 4689.7 4706.6 9458.6 9468.2 9476.6 9485.0 9493.9 5220.8 5225.0 5232.3 5246.4 5248.6 3925.4 4628.7 4765.7 4772.0 4777.2 3646.4 3688.6 3715.3 3739.3 3741.9 1167.0 1168.6 1177.8 1178.4 1179.1 720.7 771.5 775.1 781.4 790.5 5299.8 5316.0 5357.3 5398.9 5491.7 588.7 663.6 678.0 974.8 995.0 3118.9 3565.0 3629.9 3640.3 3729.6 9487.7 9719.6 9719.7 9853.3 9967.6 9923.9 9926.9 9928.2 9928.8 9967.4 7453.2 7707.6 7756.7 7761.7 7773.9 5165.7 5253.9 5414.5 5446.8 5678.4 8708.3 8889.2 8956.1 9220.0 9263.6 8901.2 9067.2 9251.5 9363.0 9401.0 7647.6 7871.5 7875.3 7875.4 7887.4 7614.0 7791.2 7851.9 7893.8 7900.0 7123.9 7141.3 7157.9 7199.4 7205.5 7031.6 7119.5 7137.0 7182.2 7242.3 5783.4 6236.0 6284.9 6290.6 6415.8 4711.1 4838.2 4896.8 4899.3 5073.5 4853.2 4877.0 4973.1 4990.7 5065.0 19:18:30 INFO - PROCESS | 1635 | 19:18:30 INFO - PROCESS | 1635 | [#4] prototype.html Cycles:180 Average:4289.57 Median:4763.62 stddev:1256.15 (26.4%) stddev-sans-first:1223.43 19:18:30 INFO - PROCESS | 1635 | Values: 298.2 354.3 365.5 372.0 373.1 4450.5 4810.5 5153.0 5196.6 5251.6 4155.8 4617.8 4627.3 4949.4 5072.0 4072.2 4084.1 4099.3 4102.3 4119.5 3268.5 3598.8 4103.4 4104.8 4109.8 2906.6 3372.8 3992.8 4046.9 4084.1 3228.6 3390.5 4024.0 4045.8 4048.0 3471.4 3570.9 3587.6 3620.4 3625.9 4281.9 4755.9 5007.8 5033.2 5074.9 4658.0 4661.6 4672.3 4677.2 4698.9 5272.9 5432.9 5439.7 5449.5 5458.5 3825.6 3900.4 3948.1 3990.1 3992.8 4818.9 5207.6 5257.5 5716.9 5741.0 3804.7 3865.4 4055.7 4060.9 4068.1 3503.8 3648.3 4000.1 4020.5 4143.2 4518.6 4558.2 4560.6 4611.4 4632.9 4595.7 5507.0 5510.2 5510.4 5514.8 1266.7 1278.6 1295.2 1303.8 1326.2 842.5 918.6 943.0 952.0 952.5 4662.3 4874.2 4926.5 4930.5 4950.6 4700.7 4828.4 4972.8 5320.8 5367.7 4573.1 4784.5 4866.6 4884.4 4928.5 2166.5 2433.8 2550.8 2571.3 2626.4 4271.0 5075.8 5315.1 5428.4 5482.6 4697.6 4771.3 4817.5 4978.7 5286.3 4848.8 4971.5 5244.8 5530.1 5551.9 5049.1 5052.7 5231.4 5277.3 5366.5 4467.5 4478.9 5223.9 5232.7 5242.3 4920.0 5450.0 5469.6 5496.8 5520.9 3407.4 3619.6 3627.9 3648.7 3913.9 4722.4 4872.2 5174.5 5209.7 5252.8 4217.0 4259.4 4575.6 4693.4 5100.9 4783.0 4890.8 5093.6 5131.8 5153.7 4505.3 5010.8 5064.3 5110.0 5189.9 4593.9 4784.4 5198.7 5336.5 5414.6 4892.7 4971.1 5014.6 5270.4 5274.9 19:18:30 INFO - PROCESS | 1635 | 19:18:30 INFO - PROCESS | 1635 | [#5] yui.html Cycles:180 Average:19660.44 Median:26199.16 stddev:27655.08 (105.6%) stddev-sans-first:27696.11 19:18:30 INFO - PROCESS | 1635 | Values: 725.7 759.4 772.7 823.1 830.2 14674.5 15583.1 15584.1 15592.5 15612.0 12122.4 14257.9 14457.9 14462.9 14477.6 664.6 685.6 688.0 843.2 862.6 834.3 845.3 860.0 861.2 863.1 923.6 925.5 925.8 926.1 927.3 690.6 712.6 886.4 917.8 918.8 686.8 692.1 692.8 693.2 693.4 15032.5 15325.6 15332.5 15346.9 15364.0 13859.0 13941.5 13945.3 14013.2 14017.8 12514.7 12572.6 12658.2 12734.5 13202.5 4397.8 4421.4 4537.3 4643.7 4653.1 101946.0 102717.0 103005.5 103537.5 104222.5 10209.8 10585.4 10611.8 11108.4 11331.8 20838.7 21327.5 21343.0 21588.7 21734.5 7475.4 7493.7 7527.8 7668.2 7679.0 4147.9 4186.6 4186.6 4213.0 4221.1 3445.5 3492.0 3518.9 3530.7 3542.5 640.1 640.5 644.6 649.5 659.8 629.5 643.6 650.0 663.0 672.5 9283.5 9626.6 9769.7 9971.1 9979.6 559.6 631.5 664.4 671.2 683.4 4359.2 4745.5 4769.3 4778.5 4795.4 76767.0 96584.6 96899.5 97777.5 98370.5 83817.7 87158.6 87373.6 88220.0 89150.0 57721.0 75226.0 75761.6 76533.0 77781.0 8487.7 8639.2 9033.8 9078.6 9426.7 35679.0 47652.8 48552.3 48865.5 49100.0 58449.4 60016.4 61267.7 62061.8 62924.1 13050.9 13272.0 13482.5 13602.8 13666.9 14589.9 14809.0 14947.3 15476.5 15490.3 13678.2 13754.8 14012.4 14096.0 14596.6 13730.2 13888.4 13898.0 14122.4 14236.0 12892.9 13317.5 13416.8 13436.4 13783.2 10979.0 11109.3 11355.9 11399.0 11957.5 8937.9 9791.6 10525.0 10750.4 10760.6 19:18:30 INFO - PROCESS | 1635 | -------- Summary: end -------- 19:18:30 INFO - PROCESS | 1635 | 19:18:30 INFO - TEST-INFO | 1635: exit 0 19:18:31 INFO - TEST-OK | dromaeo_css | took 1118324ms 19:18:31 INFO - TEST-START | kraken 19:18:31 INFO - operating with platform_type : mac_ 19:18:31 INFO - Initialising browser for kraken test... 19:18:31 INFO - TEST-INFO | started process 1644 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/tmp2Ku_wO/profile http://localhost:49236/getInfo.html) 19:18:33 INFO - PROCESS | 1644 | __metrics Screen width/height:1600/1200 19:18:33 INFO - PROCESS | 1644 | colorDepth:24 19:18:33 INFO - PROCESS | 1644 | Browser inner width/height: 1024/689 19:18:33 INFO - PROCESS | 1644 | __metrics 19:18:33 INFO - PROCESS | 1644 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 19:18:33 INFO - PROCESS | 1644 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:18:34 INFO - TEST-INFO | 1644: exit 0 19:18:34 INFO - Browser initialized. 19:18:34 INFO - Running cycle 1/1 for kraken test... 19:18:34 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/tmp2Ku_wO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:18:46 INFO - PROCESS | 1645 | RSS: Main: 235802624 19:18:46 INFO - PROCESS | 1645 | 19:18:48 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection) 19:18:49 INFO - PROCESS | 1645 | RSS: Main: 287313920 19:18:49 INFO - PROCESS | 1645 | 19:18:52 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-dft) 19:18:52 INFO - PROCESS | 1645 | RSS: Main: 286830592 19:18:52 INFO - PROCESS | 1645 | 19:18:56 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-fft) 19:18:56 INFO - PROCESS | 1645 | RSS: Main: 378720256 19:18:56 INFO - PROCESS | 1645 | 19:18:58 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator) 19:18:59 INFO - PROCESS | 1645 | RSS: Main: 282968064 19:18:59 INFO - PROCESS | 1645 | 19:19:01 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:19:02 INFO - PROCESS | 1645 | RSS: Main: 286777344 19:19:02 INFO - PROCESS | 1645 | 19:19:04 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom) 19:19:05 INFO - PROCESS | 1645 | RSS: Main: 330182656 19:19:05 INFO - PROCESS | 1645 | 19:19:08 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate) 19:19:09 INFO - PROCESS | 1645 | RSS: Main: 329871360 19:19:09 INFO - PROCESS | 1645 | 19:19:11 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial) 19:19:12 INFO - PROCESS | 1645 | RSS: Main: 329695232 19:19:12 INFO - PROCESS | 1645 | 19:19:14 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:19:14 INFO - PROCESS | 1645 | RSS: Main: 303767552 19:19:14 INFO - PROCESS | 1645 | 19:19:16 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:19:17 INFO - PROCESS | 1645 | RSS: Main: 308260864 19:19:17 INFO - PROCESS | 1645 | 19:19:19 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:19:19 INFO - PROCESS | 1645 | RSS: Main: 309723136 19:19:19 INFO - PROCESS | 1645 | 19:19:22 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:19:23 INFO - PROCESS | 1645 | RSS: Main: 325918720 19:19:23 INFO - PROCESS | 1645 | 19:19:26 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:19:27 INFO - PROCESS | 1645 | RSS: Main: 320086016 19:19:27 INFO - PROCESS | 1645 | 19:19:29 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49236/tests/kraken/driver.html?testName=ai-astar) 19:19:29 INFO - PROCESS | 1645 | RSS: Main: 364105728 19:19:29 INFO - PROCESS | 1645 | 19:19:29 INFO - PROCESS | 1645 | __start_tp_report 19:19:29 INFO - PROCESS | 1645 | _x_x_mozilla_page_load 19:19:29 INFO - PROCESS | 1645 | _x_x_mozilla_page_load_details 19:19:29 INFO - PROCESS | 1645 | |i|pagename|runs| 19:19:29 INFO - PROCESS | 1645 | |0;ai-astar;113;114;114;113;113;114;112;110;113;113 19:19:29 INFO - PROCESS | 1645 | |1;audio-beat-detection;141;112;107;150;111;108;109;109;128;112 19:19:29 INFO - PROCESS | 1645 | |2;audio-dft;184;187;185;186;182;182;182;184;182;181 19:19:29 INFO - PROCESS | 1645 | |3;audio-fft;79;59;58;87;62;60;59;58;74;57 19:19:29 INFO - PROCESS | 1645 | |4;audio-oscillator;111;100;115;56;75;99;65;82;90;111 19:19:29 INFO - PROCESS | 1645 | |5;imaging-gaussian-blur;88;85;87;87;88;85;89;85;88;85 19:19:29 INFO - PROCESS | 1645 | |6;imaging-darkroom;94;94;95;95;94;94;93;93;94;94 19:19:29 INFO - PROCESS | 1645 | |7;imaging-desaturate;87;87;87;85;84;85;87;85;87;84 19:19:29 INFO - PROCESS | 1645 | |8;json-parse-financial;57;55;55;54;56;55;56;56;55;55 19:19:29 INFO - PROCESS | 1645 | |9;json-stringify-tinderbox;68;66;81;77;74;70;69;71;71;72 19:19:29 INFO - PROCESS | 1645 | |10;stanford-crypto-aes;88;86;80;89;86;86;85;92;86;85 19:19:29 INFO - PROCESS | 1645 | |11;stanford-crypto-ccm;142;139;140;139;138;142;142;167;196;151 19:19:29 INFO - PROCESS | 1645 | |12;stanford-crypto-pbkdf2;172;182;232;187;174;172;177;228;192;176 19:19:29 INFO - PROCESS | 1645 | |13;stanford-crypto-sha256-iterative;68;68;67;66;68;65;67;67;67;67 19:19:29 INFO - PROCESS | 1645 | __end_tp_report 19:19:29 INFO - PROCESS | 1645 | __start_cc_report 19:19:29 INFO - PROCESS | 1645 | _x_x_mozilla_cycle_collect,2012 19:19:29 INFO - PROCESS | 1645 | __end_cc_report 19:19:29 INFO - PROCESS | 1645 | __startTimestamp1485314369437__endTimestamp 19:19:29 INFO - PROCESS | 1645 | 19:19:29 INFO - PROCESS | 1645 | ------- Summary: start ------- 19:19:29 INFO - PROCESS | 1645 | Number of tests: 14 19:19:29 INFO - PROCESS | 1645 | 19:19:29 INFO - PROCESS | 1645 | [#0] ai-astar Cycles:10 Average:112.90 Median:113.00 stddev:1.20 (1.1%) stddev-sans-first:1.27 19:19:29 INFO - PROCESS | 1645 | Values: 113.0 114.0 114.0 113.0 113.0 114.0 112.0 110.0 113.0 113.0 19:19:29 INFO - PROCESS | 1645 | 19:19:29 INFO - PROCESS | 1645 | [#1] audio-beat-detection Cycles:10 Average:118.70 Median:112.00 stddev:15.46 (13.8%) stddev-sans-first:14.14 19:19:29 INFO - PROCESS | 1645 | Values: 141.0 112.0 107.0 150.0 111.0 108.0 109.0 109.0 128.0 112.0 19:19:29 INFO - PROCESS | 1645 | 19:19:29 INFO - PROCESS | 1645 | [#2] audio-dft Cycles:10 Average:183.50 Median:184.00 stddev:2.01 (1.1%) stddev-sans-first:2.13 19:19:29 INFO - PROCESS | 1645 | Values: 184.0 187.0 185.0 186.0 182.0 182.0 182.0 184.0 182.0 181.0 19:19:29 INFO - PROCESS | 1645 | 19:19:29 INFO - PROCESS | 1645 | [#3] audio-fft Cycles:10 Average:65.30 Median:61.00 stddev:10.69 (17.5%) stddev-sans-first:10.12 19:19:29 INFO - PROCESS | 1645 | Values: 79.0 59.0 58.0 87.0 62.0 60.0 59.0 58.0 74.0 57.0 19:19:29 INFO - PROCESS | 1645 | 19:19:29 INFO - PROCESS | 1645 | [#4] audio-oscillator Cycles:10 Average:90.40 Median:70.00 stddev:20.43 (29.2%) stddev-sans-first:20.26 19:19:29 INFO - PROCESS | 1645 | Values: 111.0 100.0 115.0 56.0 75.0 99.0 65.0 82.0 90.0 111.0 19:19:29 INFO - PROCESS | 1645 | 19:19:29 INFO - PROCESS | 1645 | [#5] imaging-gaussian-blur Cycles:10 Average:86.70 Median:87.50 stddev:1.57 (1.8%) stddev-sans-first:1.59 19:19:29 INFO - PROCESS | 1645 | Values: 88.0 85.0 87.0 87.0 88.0 85.0 89.0 85.0 88.0 85.0 19:19:29 INFO - PROCESS | 1645 | 19:19:29 INFO - PROCESS | 1645 | [#6] imaging-darkroom Cycles:10 Average:94.00 Median:94.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 19:19:29 INFO - PROCESS | 1645 | Values: 94.0 94.0 95.0 95.0 94.0 94.0 93.0 93.0 94.0 94.0 19:19:29 INFO - PROCESS | 1645 | 19:19:29 INFO - PROCESS | 1645 | [#7] imaging-desaturate Cycles:10 Average:85.80 Median:87.00 stddev:1.32 (1.5%) stddev-sans-first:1.32 19:19:29 INFO - PROCESS | 1645 | Values: 87.0 87.0 87.0 85.0 84.0 85.0 87.0 85.0 87.0 84.0 19:19:29 INFO - PROCESS | 1645 | 19:19:29 INFO - PROCESS | 1645 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:55.50 stddev:0.84 (1.5%) stddev-sans-first:0.67 19:19:29 INFO - PROCESS | 1645 | Values: 57.0 55.0 55.0 54.0 56.0 55.0 56.0 56.0 55.0 55.0 19:19:29 INFO - PROCESS | 1645 | 19:19:29 INFO - PROCESS | 1645 | [#9] json-stringify-tinderbox Cycles:10 Average:71.90 Median:71.50 stddev:4.43 (6.2%) stddev-sans-first:4.47 19:19:29 INFO - PROCESS | 1645 | Values: 68.0 66.0 81.0 77.0 74.0 70.0 69.0 71.0 71.0 72.0 19:19:29 INFO - PROCESS | 1645 | 19:19:29 INFO - PROCESS | 1645 | [#10] stanford-crypto-aes Cycles:10 Average:86.30 Median:86.00 stddev:3.09 (3.6%) stddev-sans-first:3.22 19:19:29 INFO - PROCESS | 1645 | Values: 88.0 86.0 80.0 89.0 86.0 86.0 85.0 92.0 86.0 85.0 19:19:29 INFO - PROCESS | 1645 | 19:19:29 INFO - PROCESS | 1645 | [#11] stanford-crypto-ccm Cycles:10 Average:149.60 Median:142.00 stddev:18.51 (13.0%) stddev-sans-first:19.42 19:19:29 INFO - PROCESS | 1645 | Values: 142.0 139.0 140.0 139.0 138.0 142.0 142.0 167.0 196.0 151.0 19:19:29 INFO - PROCESS | 1645 | 19:19:29 INFO - PROCESS | 1645 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:189.20 Median:184.50 stddev:22.48 (12.2%) stddev-sans-first:22.96 19:19:29 INFO - PROCESS | 1645 | Values: 172.0 182.0 232.0 187.0 174.0 172.0 177.0 228.0 192.0 176.0 19:19:29 INFO - PROCESS | 1645 | 19:19:29 INFO - PROCESS | 1645 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.00 stddev:0.94 (1.4%) stddev-sans-first:0.93 19:19:29 INFO - PROCESS | 1645 | Values: 68.0 68.0 67.0 66.0 68.0 65.0 67.0 67.0 67.0 67.0 19:19:29 INFO - PROCESS | 1645 | -------- Summary: end -------- 19:19:29 INFO - PROCESS | 1645 | 19:19:30 INFO - TEST-INFO | 1645: exit 0 19:19:30 INFO - TEST-OK | kraken | took 59351ms 19:19:30 INFO - SUITE-END | took 1177s 19:19:30 INFO - Completed test suite (00:19:37) 19:19:30 INFO - javascript benchmark 19:19:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3224.113368823573, 3226.7418606511483, 3287.621923478799, 3295.4562497187967, 3301.9009429717107, 5531.889362212753, 5562.3881373048935, 5578.804741834037, 5590.944090559094, 5610.943890561093, 5458.781648734046, 5532.889342213153, 5599.216109744639, 5609.102543593026, 5653.293338332708, 5052.696838189702, 5064.088464076464, 5066.417362003362, 5100.719460429675, 5103.489651034885, 5135.255387968742, 5212.8436146915465, 5220.738963051851, 5223.399309079467, 5251.474852514756, 5059.747012649353, 5092.490750924915, 5178.896422071575, 5190.71451070191, 5223.843284701465, 5043.445221025684, 5102.591792656615, 5105.387353517602, 5115.462876397999, 5169.948300516984, 5050.964552266776, 5090.720010399426, 5099.923501147486, 5100.209467532539, 5150.793968241266, 5626.184203290541, 5631.943680563224, 5634.943650563524, 5642.633228840113, 5652.09566469367, 6018.458338749533, 6061.333253342129, 6066.150738896514, 6129.511613758974, 6172.444479996821, 5775.913361299584, 6229.470495007885, 6251.718672659741, 6260.467860231885, 6267.811965641038, 5777.653340799566, 5778.24882765242, 5785.913211301834, 5786.189933409326, 5794.391588883149, 6178.505719542426, 6179.28938172107, 6209.875802483925, 6228.22147231596, 6269.216347956505, 6056.273247210275, 6066.696665166724, 6075.27096748393, 6094.634321940698, 6122.2959359674205, 6098.176746139215, 6171.105189747551, 6176.69116544171, 6180.536459765535, 6180.690965451709, 6067.696615169312, 6102.938970610237, 6104.4200800923845, 6127.220070483952, 6130.245269656939, 6154.846128846725, 6178.474829639441, 6180.227471566054, 6181.8454538636, 6190.040543715641, 4077.1641813428178, 4945.901081978413, 4948.455669876311, 4965.354503914468, 4969.453360130383, 4345.826166953287, 4401.515833258339, 4425.09285596452, 4425.468943726709, 4441.4892287387365, 4844.346013288161, 5782.3639399666, 5841.50347220491, 5846.678432686158, 5850.9175802476675, 6166.290876549254, 6180.473417077209, 6207.81376558704, 6214.502839772807, 6247.0, 5740.827775166668, 5782.88434231313, 5804.1293805929445, 5808.912866307009, 5822.184894114827, 5276.947230527646, 5342.652727572773, 5345.3852806926925, 5346.91979620306, 5372.91940620891, 6207.6275423474735, 6224.221972253377, 6233.0, 6235.189425374672, 6235.719392627252, 6119.258838874149, 6137.867325793252, 6150.323464418821, 6151.815445536641, 6198.752049917953, 6265.185525881606, 6270.529710271657, 6278.246610406781, 6280.497560195082, 6304.369563043659, 6040.456358927718, 6109.083637454418, 6119.755209791559, 6120.296165940974, 6123.755049797958, 5944.851378715393, 6090.390960904051, 6146.631202127886, 6214.285357183981, 6220.409061139185, 5975.760969561169, 6054.939450605614, 6055.1522786810765, 6077.756889724362, 6105.603135796159, 5858.0, 6028.0, 6052.515798736003, 6054.182685337423, 6097.542684298606, 5664.37691853904, 5847.06446968483, 5862.94137058641, 5876.764929402776, 5897.764089436375, 5876.147958545901, 5927.377625349276, 6024.397560244116, 6053.394660534088, 6060.515158787198, 5892.705364731832, 5899.321578018583, 5917.378675239038, 5920.200772895776, 5921.052631578927], "value": 5632.886599307262, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [437.4269706684246, 450.34474839109095, 487.0721275969279, 497.18461722774657, 519.6154845414394, 30071.398572028545, 31380.686193138063, 39176.02059948499, 40736.0, 40836.77489675307, 41135.0, 41400.58599414005, 41459.585404145946, 41507.79246103765, 41599.792001039954, 9184.586693598787, 9387.530623468834, 9402.200812930909, 9404.952975235114, 9407.20038796703, 8304.750857474286, 8490.0, 9372.109649583314, 10963.890361096406, 11221.38282394468, 11051.060659843923, 11074.778504429907, 11080.889191108066, 11115.610953616626, 11178.608748693798, 9446.385984910994, 11161.49773260197, 11167.609133680364, 11169.106471482262, 11178.04986576142, 7269.3094156055095, 8216.83566328676, 8428.662853485854, 8519.872201916976, 9134.72113904054, 37796.05509862275, 39430.21139577193, 39462.80268598639, 39495.21009579821, 39529.80235098835, 3984.7609143451195, 4009.959900400988, 4040.616141466556, 4054.5337286212166, 4070.043539768152, 23485.41286467835, 29552.852235738897, 29913.03657229084, 30235.244118897204, 30371.848140759375, 3149.7952633078776, 3173.1749745066218, 3218.1311046017677, 3308.983455082709, 3312.801231926092, 479355.0, 483505.0, 484169.0, 485565.0, 486251.56874215754, 58090.90045545157, 58432.12351814726, 58432.70783646055, 58481.41518584845, 58540.707296463246, 61793.69103154545, 61794.38205617976, 61796.0, 61881.0, 61997.0, 15420.537383878502, 15685.843141568666, 15695.215239237992, 15701.450449234451, 15702.921485392728, 11038.779224415466, 11971.98238149767, 12039.879601203877, 12042.81935770964, 12106.213096148722, 13646.454141834216, 13988.440462381594, 15464.304106315243, 15666.13836238995, 15817.971831830893, 6622.96688516564, 6644.435223006002, 6669.599824010478, 6781.3046738315425, 6801.897971530431, 854.3293514591016, 875.4286056528547, 892.5581836990731, 898.1063841477771, 913.5386629751932, 28680.0, 28895.0, 29673.554896676567, 29749.702502975128, 30068.04811442785, 1045.749020235138, 1059.9099076578423, 1080.7784404197278, 1084.1706094837455, 1212.4665147335145, 14497.855021449861, 14593.905457090548, 15475.226238688021, 15584.44145624764, 15816.367345306058, 229646.70353296588, 229909.0, 230030.8498457497, 230212.0, 230302.0, 59423.702881486184, 59428.10857837049, 59452.10821837589, 59652.403475965555, 59670.0, 1432.1407155706493, 1443.314425647809, 1458.0814087125254, 1458.7301349250422, 1462.3784891421317, 27855.860720696266, 28340.574891376233, 29348.706512934597, 29379.265518362212, 29481.557776633796, 50995.0, 51347.0, 51496.48503514917, 51506.48493515017, 51650.0, 542492.0, 544759.0, 550537.0, 550557.0, 552229.0, 24166.87916560406, 24517.0, 24522.87738561296, 24539.89570469369, 24593.0, 42123.0, 43407.34888976605, 43466.13067738691, 45328.09343813171, 45635.0, 33825.0, 34225.65774342225, 35528.289434211685, 36540.63459365479, 36686.0, 35425.82287088651, 35762.8211858939, 35818.82090589531, 36827.63172368242, 36989.630103699696, 35156.824215878754, 35821.0, 36015.0, 36082.09794755152, 36113.0, 29764.85117574398, 31674.36651267008, 31789.364212715154, 32067.198320042186, 32125.67874321227, 23540.882295588413, 23833.165839195546, 23913.0, 23929.52140957206, 23953.880230598734], "value": 18845.664974890027, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.3095065800964, 382.1363717997325, 386.31429213146663, 393.6830851164812, 412.40613516536183, 15504.0, 15532.767008494868, 18765.155567999438, 20928.790712092876, 21031.0, 21917.561648767016, 22105.889470552625, 22607.886960565214, 22755.089796408167, 22900.541989160207, 5756.251687280647, 5910.704464776754, 6039.818805435844, 6111.786087486938, 6158.753649854, 3749.343864823659, 5996.7601295948325, 6042.969785151068, 6052.697365131726, 6054.909176362358, 4124.175164967019, 5081.237814327844, 6626.2711101779005, 6686.498512611549, 6749.19009718832, 6017.2779266488305, 6121.693915304217, 6233.937660623381, 6747.359000894907, 6763.323667633246, 5953.3748956359395, 5958.016927207049, 5962.463378295931, 5968.373320801296, 5973.342932277446, 12974.351282435935, 15434.073955562702, 24872.253832385057, 24906.875465622736, 25509.23472295834, 2528.2036158610163, 2574.1505303249883, 2629.2585968984863, 2648.1261183809297, 2761.502929472694, 9834.606615735362, 10423.530941107669, 10425.739356516073, 11045.779084418267, 12326.753464930742, 1825.6896327624336, 1828.277830257041, 1859.4049904030715, 1866.7013277875474, 1871.8023789556232, 115665.0, 118686.40656796747, 119020.0, 120713.0, 123450.38274808659, 9828.754281142885, 9960.452175130293, 11498.252613580258, 11515.251508652078, 11670.70823229426, 15552.533423997298, 15571.143587102591, 15578.610534736723, 15590.610234743996, 15611.921940390226, 6841.315868413119, 8455.069942306342, 8617.655293788179, 8677.305815534743, 8724.65101395937, 7062.71749130029, 8335.291500222427, 8342.081528248083, 8367.539785311745, 8493.0465992822, 4468.821247150143, 4702.764861756898, 4709.081729062868, 4715.976420117878, 4801.351817504592, 1741.4340339389748, 1996.9500762481055, 1998.2007197120977, 2002.9399118026483, 2004.5088953206557, 986.5166068626321, 1003.6136087606324, 1017.3539802225492, 1039.2725092435326, 1073.8872418396113, 18047.458576242472, 19564.804351956584, 21739.34781956544, 21956.011979460964, 22130.889345553493, 1027.7944411117805, 1047.5443182215608, 1069.641670040545, 1082.5994382078682, 1084.208527774713, 10076.848847267296, 11480.0, 11485.425728713699, 11494.0, 11510.366929818772, 735244.0, 744640.0, 746022.0, 752405.0, 757222.0, 112973.0, 129543.35228323798, 135048.3247583756, 156850.0, 159786.0, 1041.8801837788599, 1058.3596923860953, 1093.049047328813, 1095.9452027398759, 1097.8188598881095, 18673.879567225467, 19590.60818783588, 20204.29284975019, 20206.19175232974, 20705.720385482455, 47340.289895652284, 54702.0, 61408.692956534935, 63337.68331158315, 63441.0, 81413.77879331933, 82389.0, 86515.56742216248, 87717.56141219253, 89420.0, 7244.927550724426, 7512.9624351880075, 7584.241575842371, 7978.800529986796, 8470.788230294293, 10837.78324433491, 12890.904273136513, 13081.672958176121, 13175.868241317847, 13550.390232439368, 11307.265027773168, 11630.011449026928, 11636.301821890713, 11742.356070150357, 11885.762284754084, 11438.084953203557, 11509.482073306554, 11640.650780476599, 11719.824202637137, 11877.346745929057, 11418.0, 11519.366434846164, 11748.530058797553, 12032.639020829389, 12056.156069075081, 7443.627818609156, 7521.172671006294, 7638.0, 7663.160841398136, 7786.5717385542075, 10382.0, 11291.096712263163, 11586.536538538701, 11712.70718232051, 11827.763444730885], "value": 9864.589022995258, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1300.2653500772067, 1447.610294117647, 1473.646324882028, 1475.041223204916, 1485.2796393749034, 7979.441439099265, 8413.242808147266, 8438.240558349748, 8447.23974842264, 8448.78878028048, 7398.482106252564, 7682.308592226698, 7689.961855149553, 7982.600869956494, 8074.354051675867, 2256.593813113639, 2293.5068960173558, 2297.597920363938, 2302.769723027692, 2308.4459729664845, 2218.4232099654128, 2313.201945328867, 2321.791038806507, 2325.046730840356, 2326.7673232676766, 2057.9897100514477, 2125.564259326842, 2133.296012315932, 2240.764719704432, 2312.3294244669028, 2312.7918487336137, 2332.7783860533223, 2336.9649455258186, 2341.4497593065616, 2346.389938615955, 2009.3770931011288, 2272.8068114210314, 2355.0462062864567, 2358.9410264743346, 2360.0205914545445, 7164.785056448315, 8377.413581049268, 8427.831443371098, 8467.49195048299, 8469.32245420365, 5020.297158397827, 5184.196449550326, 5192.7403629818355, 5197.0, 5203.063448579254, 3048.542718592229, 3390.440577304742, 3398.762086653935, 3536.204354020325, 3600.225951420457, 1209.8911098001222, 1233.0690328801786, 1269.0799170601333, 1282.4805953588718, 1290.3999640167274, 10827.729306767395, 10903.34579925207, 10910.454477276184, 10915.345079295268, 10920.12638988879, 3844.884653460401, 4127.236461254677, 4392.3191905254735, 4689.718616882929, 4706.576408123286, 9458.57436415363, 9468.195203407788, 9476.620935162655, 9485.004074572209, 9493.857592136124, 5220.791168353223, 5225.033368826703, 5232.2674825524455, 5246.422893481714, 5248.606354523426, 3925.371940489508, 4628.699134556243, 4765.737884416321, 4771.974025584516, 4777.211760059621, 3646.4165733482514, 3688.61269566697, 3715.2569486102348, 3739.3456145174487, 3741.9251614967548, 1166.9941650291694, 1168.5617893290016, 1177.8233265010147, 1178.3577950017261, 1179.0626451970704, 720.6648908257686, 771.4792515052317, 775.1163673412202, 781.3631890009624, 790.5414859381544, 5299.761510732026, 5316.016536940679, 5357.330333708286, 5398.9472052949295, 5491.7254137292975, 588.6762280745659, 663.5985228936424, 677.9796606101825, 974.8245315843217, 994.9701508954598, 3118.875244990175, 3564.9643503564635, 3629.94555081674, 3640.308341415123, 3729.5524537055726, 9487.66793162236, 9719.61121555144, 9719.659811906691, 9853.310268281295, 9967.601295948081, 9923.900760992443, 9926.900730992742, 9928.220098372323, 9928.80142397148, 9967.40195588267, 7453.217412171753, 7707.576083315472, 7756.689732410753, 7761.728339508203, 7773.883391749128, 5165.690058596496, 5253.868653283698, 5414.512693857571, 5446.836594902159, 5678.403767604342, 8708.346873984603, 8889.19997200255, 8956.149165829236, 9219.953900230455, 9263.629454822001, 8901.243394311556, 9067.183953444222, 9251.491167985825, 9362.95318523403, 9401.0, 7647.617619118911, 7871.527708337518, 7875.291223789886, 7875.409344299086, 7887.44787864844, 7614.010178676736, 7791.220877912164, 7851.9214807851195, 7893.763187104396, 7899.973003509507, 7123.857522849617, 7141.250168732416, 7157.928420715934, 7199.424046076197, 7205.459590530626, 7031.613261270679, 7119.466040046914, 7137.017456062476, 7182.245864184394, 7242.311980361857, 5783.421657834183, 6236.03341482071, 6284.937150628435, 6290.591111577733, 6415.8396040097505, 4711.081339138835, 4838.225883858566, 4896.804127834846, 4899.265110233351, 5073.467285934924, 4853.223484242645, 4877.048975449895, 4973.104841128632, 4990.72551009698, 5064.9746751267485], "value": 4334.5249626537025, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.24543903923075, 354.2510121457489, 365.53576957264266, 371.96466335698096, 373.14177391998396, 4450.465944086714, 4810.518948105192, 5152.974235128819, 5196.636235463514, 5251.555822148911, 4155.792210389476, 4617.8152873885, 4627.305904114384, 4949.406071271444, 5072.0, 4072.165206132736, 4084.1219137885423, 4099.303118469852, 4102.2821006323775, 4119.505659320886, 3268.509723541476, 3598.784072955631, 4103.38449232616, 4104.79476026199, 4109.794510274489, 2906.564015397686, 3372.797632142067, 3992.8420757980152, 4046.858359957402, 4084.0810817565957, 3228.564143840575, 3390.5253264542985, 4023.959760402388, 4045.8381664733374, 4047.955782329934, 3471.4272145096284, 3570.875329179134, 3587.605363410049, 3620.3845346291196, 3625.8912232633065, 4281.93216444376, 4755.9286610700865, 5007.824726134568, 5033.1814184056675, 5074.908894587645, 4658.0, 4661.557152070548, 4672.322513235596, 4677.228257337535, 4698.882527936795, 5272.92090618641, 5432.945670543283, 5439.673619582838, 5449.536789372908, 5458.536024437927, 3825.5791862895057, 3900.395438707005, 3948.1314110895555, 3990.1221731219084, 3992.800359982018, 4818.855609253884, 5207.609429292818, 5257.526822585909, 5716.857078573027, 5740.999999999958, 3804.6575808176844, 3865.40086286626, 4055.6755459563165, 4060.878173654795, 4068.1253530490494, 3503.7547371683736, 3648.3432982062955, 4000.0592455084475, 4020.4974378202724, 4143.150654115899, 4518.593326600556, 4558.156741002925, 4560.612347950395, 4611.400517932714, 4632.930506042345, 4595.736172552508, 5507.0, 5510.173473978855, 5510.366307874646, 5514.779408823602, 1266.7086570088932, 1278.6355888571713, 1295.2487557216791, 1303.843538775334, 1326.2440408966988, 842.4987132656059, 918.554501066982, 942.9528523573794, 951.986548450037, 952.4808979106404, 4662.254039353687, 4874.195757699939, 4926.507349265116, 4930.457649658535, 4950.628702847301, 4700.694454860423, 4828.447285621563, 4972.825951091694, 5320.76056577455, 5367.651102678314, 4573.118935070884, 4784.545468180518, 4866.586340161055, 4884.3650325457465, 4928.482509336468, 2166.512534679716, 2433.841800282976, 2550.7576780206223, 2571.251548946734, 2626.439221758808, 4271.002926575914, 5075.847724568195, 5315.066850530657, 5428.4028756836715, 5482.616216864782, 4697.647676424282, 4771.308160316735, 4817.518248175154, 4978.651494395358, 5286.3392075990505, 4848.781804818721, 4971.527704868032, 5244.790208391774, 5530.1243353455975, 5551.916721249185, 5049.147231814013, 5052.69683818972, 5231.372235331784, 5277.2875661785165, 5366.517013468807, 4467.486239082417, 4478.910421791611, 5223.884326847633, 5232.738363081907, 5242.292290540729, 4920.0, 5450.040463178489, 5469.5696485845, 5496.835094947158, 5520.889582208413, 3407.352603005421, 3619.6380361963593, 3627.9274414511033, 3648.744587878823, 3913.8630147944687, 4722.409698787652, 4872.220444728827, 5174.508421699932, 5209.723617713685, 5252.789888404421, 4216.957830421657, 4259.42497762798, 4575.58819706228, 4693.389859318267, 5100.948990510047, 4782.962818610138, 4890.793917231107, 5093.567046801063, 5131.769070391916, 5153.742312884416, 4505.301678239878, 5010.849674509771, 5064.316317297118, 5109.952459745818, 5189.948100519097, 4593.862184134481, 4784.449788274393, 5198.6880787152895, 5336.504589493888, 5414.593905457185, 4892.657513973988, 4971.09191123197, 5014.5737612303365, 5270.446603106772, 5274.868128296824], "value": 3909.735424573066, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [725.7278520554792, 759.4304271796153, 772.7025095338294, 823.1315961660449, 830.1698301698302, 14674.486392976249, 15583.142927139002, 15584.064956102613, 15592.45426410076, 15612.0, 12122.393880305972, 14257.92871035646, 14457.855421445782, 14462.855371446283, 14477.565673029825, 664.5979182594521, 685.568092101975, 687.9621620810854, 843.2115971566604, 862.5816479007676, 834.2866848844242, 845.3490812074699, 859.9699010534632, 861.1646702698373, 863.1497974495118, 923.6213152607432, 925.4724806860092, 925.759302581327, 926.0831776541243, 927.2628260532858, 690.6408667492875, 712.6365553567666, 886.3795343259744, 917.8302014127407, 918.7932715139107, 686.800827759949, 692.0933577014127, 692.7506097804786, 693.237438817302, 693.448708276921, 15032.473863414838, 15325.616859578487, 15332.540023799304, 15346.923265383602, 15364.0, 13859.0, 13941.512047078304, 13945.302734863319, 14013.207256537798, 14017.775911540402, 12514.74970500594, 12572.559960401433, 12658.240505569695, 12734.490620375174, 13202.537911173158, 4397.802098905557, 4421.358902959085, 4537.296719008559, 4643.744594047326, 4653.115907977473, 101946.0, 102717.0, 103005.4849725754, 103537.4823125887, 104222.47888760583, 10209.795804083877, 10585.364878107184, 10611.84082238767, 11108.444577771079, 11331.830022549668, 20838.68741968872, 21327.46681332979, 21343.039563219692, 21588.676169857466, 21734.45663858416, 7475.364594009461, 7493.70025198986, 7527.774166775005, 7668.194839541879, 7678.96160519205, 4147.896302592399, 4186.581341865789, 4186.602272784081, 4213.0, 4221.071364299849, 3445.4831775233915, 3491.965080349215, 3518.894433167009, 3530.735194860396, 3542.5040494330815, 640.065504363625, 640.5420124610926, 644.6357807838556, 649.4998850884792, 659.8090446743673, 629.4523764325066, 643.6041834271982, 649.9740010399531, 662.9635370054693, 672.4687496877413, 9283.48940808262, 9626.566804493814, 9769.706908792748, 9971.05274998874, 9979.602855600222, 559.5914982063035, 631.5358211714387, 664.3821246241042, 671.194566520168, 683.3656255136377, 4359.215341238608, 4745.549172828576, 4769.308450274691, 4778.450478194983, 4795.400574928134, 76767.0, 96584.55123173157, 96899.51550242204, 97777.51111244399, 98370.50814745881, 83817.74273385904, 87158.56420717982, 87373.56313218393, 88219.95780758683, 89150.0, 57721.0, 75226.0, 75761.62119189369, 76532.99999999888, 77781.0, 8487.702930397407, 8639.23766144253, 9033.77415564616, 9078.636854525745, 9426.717198484057, 35679.0, 47652.761736191096, 48552.27171592358, 48865.51134488752, 49100.0, 58449.415505844394, 60016.39983600283, 61267.693661531404, 62061.795899600096, 62924.05613915886, 13050.934745326213, 13272.0, 13482.46070157222, 13602.795958060438, 13666.93166534161, 14589.85410145885, 14809.0, 14947.252637368305, 15476.458323958608, 15490.289199390287, 13678.247696376397, 13754.793678095037, 14012.369443374868, 14096.0, 14596.562103136923, 13730.244836534086, 13888.375023123781, 13898.0, 14122.43510259578, 14236.0, 12892.935535322264, 13317.467301307839, 13416.798748018982, 13436.395362208528, 13783.173009619455, 10979.0, 11109.333439993627, 11355.886441135483, 11399.0, 11957.461914213707, 8937.865932010895, 9791.608335666493, 10525.0, 10750.408727519749, 10760.62337818204], "value": 7411.394093326894, "unit": "score"}], "name": "dromaeo_css", "value": 7131.427675888575, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 114.0, 113.0, 113.0, 114.0, 112.0, 110.0, 113.0, 113.0], "value": 112.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 112.0, 107.0, 150.0, 111.0, 108.0, 109.0, 109.0, 128.0, 112.0], "value": 118.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 187.0, 185.0, 186.0, 182.0, 182.0, 182.0, 184.0, 182.0, 181.0], "value": 183.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 59.0, 58.0, 87.0, 62.0, 60.0, 59.0, 58.0, 74.0, 57.0], "value": 65.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 100.0, 115.0, 56.0, 75.0, 99.0, 65.0, 82.0, 90.0, 111.0], "value": 90.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 87.0, 87.0, 88.0, 85.0, 89.0, 85.0, 88.0, 85.0], "value": 86.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 95.0, 94.0, 94.0, 93.0, 93.0, 94.0, 94.0], "value": 94.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 87.0, 85.0, 84.0, 85.0, 87.0, 85.0, 87.0, 84.0], "value": 85.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 55.0, 55.0, 54.0, 56.0, 55.0, 56.0, 56.0, 55.0, 55.0], "value": 55.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 81.0, 77.0, 74.0, 70.0, 69.0, 71.0, 71.0, 72.0], "value": 71.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 80.0, 89.0, 86.0, 86.0, 85.0, 92.0, 86.0, 85.0], "value": 86.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 139.0, 140.0, 139.0, 138.0, 142.0, 142.0, 167.0, 196.0, 151.0], "value": 149.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 182.0, 232.0, 187.0, 174.0, 172.0, 177.0, 228.0, 192.0, 176.0], "value": 189.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 67.0, 66.0, 68.0, 65.0, 67.0, 67.0, 67.0, 67.0], "value": 67.0, "unit": "score"}], "name": "kraken", "value": 1456.7, "alertThreshold": 2.0}]} 19:19:30 INFO - Return code: 0 19:19:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:19:30 ERROR - # TBPL SUCCESS # 19:19:30 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:19:30 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:19:30 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:19:30 INFO - 2017-01-24 19:19:30.741 screenresolution[1649:9682] starting screenresolution argv=screenresolution get 19:19:30 INFO - 2017-01-24 19:19:30.743 screenresolution[1649:9682] Display 0: 1600x1200x32@60 19:19:30 INFO - 2017-01-24 19:19:30.750 screenresolution[1650:9685] starting screenresolution argv=screenresolution list 19:19:30 INFO - Available Modes on Display 0 19:19:30 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:19:30 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:19:30 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:19:30 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:19:30 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:19:30 INFO - Intel Iris: 19:19:30 INFO - Chipset Model: Intel Iris 19:19:30 INFO - Type: GPU 19:19:30 INFO - Bus: Built-In 19:19:30 INFO - VRAM (Dynamic, Max): 1536 MB 19:19:30 INFO - Vendor: Intel (0x8086) 19:19:30 INFO - Device ID: 0x0a2e 19:19:30 INFO - Revision ID: 0x0009 19:19:30 INFO - Displays: 19:19:30 INFO - Display: 19:19:30 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:19:30 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:19:30 INFO - Display Serial Number: 1600x1200 60 19:19:30 INFO - Main Display: Yes 19:19:30 INFO - Mirror: Off 19:19:30 INFO - Online: Yes 19:19:30 INFO - Rotation: Supported 19:19:30 INFO - Return code: 0 19:19:30 INFO - Running post-action listener: _resource_record_post_action 19:19:30 INFO - [mozharness: 2017-01-25 03:19:30.985191Z] Finished run-tests step (success) 19:19:30 INFO - Running post-run listener: _resource_record_post_run 19:19:31 INFO - Total resource usage - Wall time: 1200s; CPU: 54.0%; Read bytes: 38827008; Write bytes: 549824000; Read time: 376; Write time: 1608 19:19:31 INFO - TinderboxPrint: CPU usage
53.8% 19:19:31 INFO - TinderboxPrint: I/O read bytes / time
38,827,008 / 376 19:19:31 INFO - TinderboxPrint: I/O write bytes / time
549,824,000 / 1,608 19:19:31 INFO - TinderboxPrint: CPU idle
2,216.8 (46.2%) 19:19:31 INFO - TinderboxPrint: CPU system
961.8 (20.0%) 19:19:31 INFO - TinderboxPrint: CPU user
1,623.1 (33.8%) 19:19:31 INFO - TinderboxPrint: Swap in / out
289,947,648 / 0 19:19:31 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 245705216; Write bytes: 237998080; Read time: 17798; Write time: 458 19:19:31 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 36758528; Write bytes: 296080896; Read time: 354; Write time: 1116 19:19:31 INFO - Running post-run listener: _upload_blobber_files 19:19:31 INFO - Blob upload gear active. 19:19:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:19:31 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 19:19:31 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:19:31 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:19:31 INFO - (blobuploader) - INFO - Open directory for files ... 19:19:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:19:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:19:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:19:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:19:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:19:32 INFO - (blobuploader) - INFO - Done attempting. 19:19:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:19:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:19:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:19:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:19:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:19:33 INFO - (blobuploader) - INFO - Done attempting. 19:19:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 19:19:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:19:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:19:34 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 19:19:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:19:34 INFO - (blobuploader) - INFO - Done attempting. 19:19:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:19:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:19:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:19:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:19:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:19:36 INFO - (blobuploader) - INFO - Done attempting. 19:19:36 INFO - (blobuploader) - INFO - Iteration through files over. 19:19:36 INFO - Return code: 0 19:19:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:19:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:19:36 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3dd424e761cba2f1da5fd9c31368189f86a6dbbda06fc746a619f3e14a973908843b9e15abf61f27d1a104b692f8a70bb28d283a6eae525ef96051f1949c43c2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9289812572aabf8dc378b3925d3695371ce0afbdd7f18fa7f48596910d2bb073db632c458e197ae9d4f37fb05d217487f5cfda095d0978772a82890b38c982e3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/66089b5ef40c0d0cbcd6627ec92977e8e316969669eac8b0acddfd7a0fb9eba553371a0d72765306f8ed4b1a8064e0595d2fe199c278d59b4e4e772c870a3a4c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d9b8ea385ab09468872d88ba00f0345351cc72394d4f7a0af2626c12f305e9c75edbaac4a8abae16fac559d7dc066114b33b5537220485d927877970836eae99"} 19:19:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:19:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:19:36 INFO - Contents: 19:19:36 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3dd424e761cba2f1da5fd9c31368189f86a6dbbda06fc746a619f3e14a973908843b9e15abf61f27d1a104b692f8a70bb28d283a6eae525ef96051f1949c43c2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9289812572aabf8dc378b3925d3695371ce0afbdd7f18fa7f48596910d2bb073db632c458e197ae9d4f37fb05d217487f5cfda095d0978772a82890b38c982e3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/66089b5ef40c0d0cbcd6627ec92977e8e316969669eac8b0acddfd7a0fb9eba553371a0d72765306f8ed4b1a8064e0595d2fe199c278d59b4e4e772c870a3a4c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d9b8ea385ab09468872d88ba00f0345351cc72394d4f7a0af2626c12f305e9c75edbaac4a8abae16fac559d7dc066114b33b5537220485d927877970836eae99"} 19:19:36 INFO - Running post-run listener: copy_logs_to_upload_dir 19:19:36 INFO - Copying logs to upload dir... 19:19:36 INFO - mkdir: /builds/slave/test/build/upload/logs 19:19:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.441621 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-01-24 19:19:36.742693) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-24 19:19:36.746126) ========= 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.QNtLpvW9Jc/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.V1um4lEnxM/Listeners TMPDIR=/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3dd424e761cba2f1da5fd9c31368189f86a6dbbda06fc746a619f3e14a973908843b9e15abf61f27d1a104b692f8a70bb28d283a6eae525ef96051f1949c43c2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9289812572aabf8dc378b3925d3695371ce0afbdd7f18fa7f48596910d2bb073db632c458e197ae9d4f37fb05d217487f5cfda095d0978772a82890b38c982e3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/66089b5ef40c0d0cbcd6627ec92977e8e316969669eac8b0acddfd7a0fb9eba553371a0d72765306f8ed4b1a8064e0595d2fe199c278d59b4e4e772c870a3a4c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d9b8ea385ab09468872d88ba00f0345351cc72394d4f7a0af2626c12f305e9c75edbaac4a8abae16fac559d7dc066114b33b5537220485d927877970836eae99"} build_url:https://queue.taskcluster.net/v1/task/GcbUBbm3Q2OUSE5H79AZ6Q/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011134 build_url: 'https://queue.taskcluster.net/v1/task/GcbUBbm3Q2OUSE5H79AZ6Q/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3dd424e761cba2f1da5fd9c31368189f86a6dbbda06fc746a619f3e14a973908843b9e15abf61f27d1a104b692f8a70bb28d283a6eae525ef96051f1949c43c2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9289812572aabf8dc378b3925d3695371ce0afbdd7f18fa7f48596910d2bb073db632c458e197ae9d4f37fb05d217487f5cfda095d0978772a82890b38c982e3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/66089b5ef40c0d0cbcd6627ec92977e8e316969669eac8b0acddfd7a0fb9eba553371a0d72765306f8ed4b1a8064e0595d2fe199c278d59b4e4e772c870a3a4c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d9b8ea385ab09468872d88ba00f0345351cc72394d4f7a0af2626c12f305e9c75edbaac4a8abae16fac559d7dc066114b33b5537220485d927877970836eae99"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-24 19:19:36.781022) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 19:19:36.781358) ========= 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.QNtLpvW9Jc/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.V1um4lEnxM/Listeners TMPDIR=/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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.005324 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 19:19:36.830755) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-24 19:19:36.831075) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-24 19:19:36.831411) ========= ========= Total master_lag: 0.18 =========