builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0191 starttime: 1490195448.11 results: success (0) buildid: 20170322062735 builduid: 64327b50a3954967a24ccab4e43a2675 revision: 27f7aadeea833eca8c9c0e24c858f798e4d6fdd8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-22 08:10:48.107547) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-22 08:10:48.108346) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-22 08:10:48.108855) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-22 08:10:48.139543) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-22 08:10:48.140012) ========= 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.7bhy4ILqLD/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.8B38FVUj5M/Listeners TMPDIR=/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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-03-22 08:10:48-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 14.6M=0.001s 2017-03-22 08:10:48 (14.6 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.116272 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-22 08:10:48.282651) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-22 08:10:48.283206) ========= 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.7bhy4ILqLD/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.8B38FVUj5M/Listeners TMPDIR=/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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.028034 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-22 08:10:48.335683) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2017-03-22 08:10:48.336305) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 27f7aadeea833eca8c9c0e24c858f798e4d6fdd8 --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 27f7aadeea833eca8c9c0e24c858f798e4d6fdd8 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.7bhy4ILqLD/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.8B38FVUj5M/Listeners TMPDIR=/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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-03-22 08:10:48,382 truncating revision to first 12 chars 2017-03-22 08:10:48,383 Setting DEBUG logging. 2017-03-22 08:10:48,383 attempt 1/10 2017-03-22 08:10:48,383 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/27f7aadeea83?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-22 08:10:49,446 unpacking tar archive at: mozilla-central-27f7aadeea83/testing/mozharness/ program finished with exit code 0 elapsedTime=1.338789 ========= master_lag: 2.43 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2017-03-22 08:10:52.101390) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-22 08:10:52.101946) ========= script_repo_revision: 27f7aadeea833eca8c9c0e24c858f798e4d6fdd8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-22 08:10:52.102619) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-22 08:10:52.103102) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-22 08:10:52.139863) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2017-03-22 08:10:52.140517) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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.7bhy4ILqLD/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.8B38FVUj5M/Listeners TMPDIR=/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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 08:10:52 INFO - MultiFileLogger online at 20170322 08:10:52 in /builds/slave/test 08:10:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 08:10:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:10:52 INFO - {'append_to_log': False, 08:10:52 INFO - 'base_work_dir': '/builds/slave/test', 08:10:52 INFO - 'blob_upload_branch': 'Firefox', 08:10:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:10:52 INFO - 'branch': 'Firefox', 08:10:52 INFO - 'buildbot_json_path': 'buildprops.json', 08:10:52 INFO - 'config_files': ('talos/mac_config.py',), 08:10:52 INFO - 'default_actions': ('clobber', 08:10:52 INFO - 'read-buildbot-config', 08:10:52 INFO - 'download-and-extract', 08:10:52 INFO - 'populate-webroot', 08:10:52 INFO - 'create-virtualenv', 08:10:52 INFO - 'install', 08:10:52 INFO - 'run-tests'), 08:10:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:10:52 INFO - 'download_minidump_stackwalk': True, 08:10:52 INFO - 'download_symbols': 'ondemand', 08:10:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:10:52 INFO - 'tooltool.py': '/tools/tooltool.py', 08:10:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:10:52 INFO - '/tools/misc-python/virtualenv.py')}, 08:10:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:10:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:10:52 INFO - 'gecko_profile': False, 08:10:52 INFO - 'gecko_profile_interval': 0, 08:10:52 INFO - 'installer_path': 'installer.exe', 08:10:52 INFO - 'log_level': 'info', 08:10:52 INFO - 'log_name': 'talos', 08:10:52 INFO - 'log_to_console': True, 08:10:52 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:10:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:10:52 INFO - 'opt_config_files': (), 08:10:52 INFO - 'pip_index': False, 08:10:52 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:10:52 INFO - 'cmd': ('bash', 08:10:52 INFO - '-c', 08:10:52 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:10:52 INFO - 'enabled': True, 08:10:52 INFO - 'halt_on_failure': False, 08:10:52 INFO - 'name': 'check_screen_resolution'},), 08:10:52 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:10:52 INFO - 'cmd': ('bash', 08:10:52 INFO - '-c', 08:10:52 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:10:52 INFO - 'enabled': True, 08:10:52 INFO - 'halt_on_failure': False, 08:10:52 INFO - 'name': 'check_screen_resolution'},), 08:10:52 INFO - 'run_cmd_checks_enabled': True, 08:10:52 INFO - 'suite': 'dromaeojs-e10s', 08:10:52 INFO - 'system_bits': '32', 08:10:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:10:52 INFO - 'title': 't-yosemite-r7-0191', 08:10:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:10:52 INFO - 'use_talos_json': True, 08:10:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:10:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:10:52 INFO - 'work_dir': 'build'} 08:10:52 INFO - [mozharness: 2017-03-22 15:10:52.300451Z] Running clobber step. 08:10:52 INFO - Running pre-action listener: _resource_record_pre_action 08:10:52 INFO - Running main action method: clobber 08:10:52 INFO - rmtree: /builds/slave/test/build 08:10:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:10:54 INFO - Running post-action listener: _resource_record_post_action 08:10:54 INFO - [mozharness: 2017-03-22 15:10:54.721436Z] Finished clobber step (success) 08:10:54 INFO - [mozharness: 2017-03-22 15:10:54.721599Z] Running read-buildbot-config step. 08:10:54 INFO - Running pre-action listener: _resource_record_pre_action 08:10:54 INFO - Running main action method: read_buildbot_config 08:10:54 INFO - Using buildbot properties: 08:10:54 INFO - { 08:10:54 INFO - "project": "", 08:10:54 INFO - "product": "firefox", 08:10:54 INFO - "script_repo_revision": "production", 08:10:54 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 08:10:54 INFO - "repository": "", 08:10:54 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 08:10:54 INFO - "buildid": "20170322062735", 08:10:54 INFO - "pgo_build": "False", 08:10:54 INFO - "basedir": "/builds/slave/test", 08:10:54 INFO - "buildnumber": 17, 08:10:54 INFO - "slavename": "t-yosemite-r7-0191", 08:10:54 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 08:10:54 INFO - "platform": "yosemite_r7", 08:10:54 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 08:10:54 INFO - "branch": "mozilla-central", 08:10:54 INFO - "repo_path": "mozilla-central", 08:10:54 INFO - "revision": "27f7aadeea833eca8c9c0e24c858f798e4d6fdd8", 08:10:54 INFO - "stage_platform": "macosx64", 08:10:54 INFO - "builduid": "64327b50a3954967a24ccab4e43a2675", 08:10:54 INFO - "slavebuilddir": "test" 08:10:54 INFO - } 08:10:54 INFO - Found installer url https://queue.taskcluster.net/v1/task/Pe-aGIinRvaB-MuJm7ikhQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 08:10:54 INFO - Running post-action listener: _resource_record_post_action 08:10:54 INFO - [mozharness: 2017-03-22 15:10:54.724862Z] Finished read-buildbot-config step (success) 08:10:54 INFO - [mozharness: 2017-03-22 15:10:54.724972Z] Running download-and-extract step. 08:10:54 INFO - Running pre-action listener: _resource_record_pre_action 08:10:54 INFO - Running main action method: download_and_extract 08:10:54 INFO - mkdir: /builds/slave/test/build/tests 08:10:54 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')]} 08:10:54 INFO - trying https://queue.taskcluster.net/v1/task/Pe-aGIinRvaB-MuJm7ikhQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 08:10:54 INFO - Downloading https://queue.taskcluster.net/v1/task/Pe-aGIinRvaB-MuJm7ikhQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 08:10:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Pe-aGIinRvaB-MuJm7ikhQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 08:10:55 INFO - Downloaded 1325 bytes. 08:10:55 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 08:10:55 INFO - Using the following test package requirements: 08:10:55 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 08:10:55 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 08:10:55 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 08:10:55 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 08:10:55 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 08:10:55 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 08:10:55 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 08:10:55 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 08:10:55 INFO - u'jsshell-mac.zip'], 08:10:55 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 08:10:55 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 08:10:55 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 08:10:55 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 08:10:55 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 08:10:55 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 08:10:55 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 08:10:55 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 08:10:55 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 08:10:55 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 08:10:55 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 08:10:55 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 08:10:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Pe-aGIinRvaB-MuJm7ikhQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 08:10:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Pe-aGIinRvaB-MuJm7ikhQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:10:55 INFO - Fetch https://queue.taskcluster.net/v1/task/Pe-aGIinRvaB-MuJm7ikhQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 08:10:57 INFO - Expected file size: 52402011 08:10:57 INFO - Obtained file size: 52402011 08:11:14 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 08:11:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Pe-aGIinRvaB-MuJm7ikhQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 08:11:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Pe-aGIinRvaB-MuJm7ikhQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:11:14 INFO - Fetch https://queue.taskcluster.net/v1/task/Pe-aGIinRvaB-MuJm7ikhQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 08:11:15 INFO - Expected file size: 52402011 08:11:15 INFO - Obtained file size: 52402011 08:11:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Pe-aGIinRvaB-MuJm7ikhQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 08:11:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Pe-aGIinRvaB-MuJm7ikhQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 08:11:31 INFO - Fetch https://queue.taskcluster.net/v1/task/Pe-aGIinRvaB-MuJm7ikhQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 08:11:32 INFO - Expected file size: 14404171 08:11:32 INFO - Obtained file size: 14404171 08:11:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:11:33 INFO - trying https://queue.taskcluster.net/v1/task/Pe-aGIinRvaB-MuJm7ikhQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 08:11:33 INFO - Downloading https://queue.taskcluster.net/v1/task/Pe-aGIinRvaB-MuJm7ikhQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 08:11:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Pe-aGIinRvaB-MuJm7ikhQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 08:11:35 INFO - Downloaded 75370627 bytes. 08:11:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Pe-aGIinRvaB-MuJm7ikhQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 08:11:35 INFO - mkdir: /builds/slave/test/properties 08:11:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:11:35 INFO - Writing to file /builds/slave/test/properties/build_url 08:11:35 INFO - Contents: 08:11:35 INFO - build_url:https://queue.taskcluster.net/v1/task/Pe-aGIinRvaB-MuJm7ikhQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 08:11:35 INFO - Running post-action listener: _resource_record_post_action 08:11:35 INFO - Running post-action listener: set_extra_try_arguments 08:11:35 INFO - [mozharness: 2017-03-22 15:11:35.942149Z] Finished download-and-extract step (success) 08:11:35 INFO - [mozharness: 2017-03-22 15:11:35.942289Z] Running populate-webroot step. 08:11:35 INFO - Running pre-action listener: _resource_record_pre_action 08:11:35 INFO - Running main action method: populate_webroot 08:11:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:11:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:11:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:11:35 INFO - '--tppagecycles', 08:11:35 INFO - '7'], 08:11:35 INFO - 'tests': ['tsvgm']}}, 08:11:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:11:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:11:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:11:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:11:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:11:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:11:35 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:11:35 INFO - 'talos_options': ['--disable-e10s'], 08:11:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:11:35 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:11:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:11:35 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:11:35 INFO - 'talos_options': ['--disable-e10s'], 08:11:35 INFO - 'tests': ['damp', 'tps']}, 08:11:35 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:11:35 INFO - 'tests': ['damp', 'tps']}, 08:11:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:11:35 INFO - 'tests': ['dromaeo_dom']}, 08:11:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:11:35 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:11:35 INFO - 'tests': ['basic_compositor_video']}, 08:11:35 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:11:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:11:35 INFO - 'tests': ['a11yr', 08:11:35 INFO - 'ts_paint', 08:11:35 INFO - 'tpaint', 08:11:35 INFO - 'sessionrestore', 08:11:35 INFO - 'sessionrestore_no_auto_restore', 08:11:35 INFO - 'tabpaint']}, 08:11:35 INFO - 'other-e10s': {'tests': ['a11yr', 08:11:35 INFO - 'ts_paint', 08:11:35 INFO - 'tpaint', 08:11:35 INFO - 'sessionrestore', 08:11:35 INFO - 'sessionrestore_no_auto_restore', 08:11:35 INFO - 'tabpaint']}, 08:11:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:11:35 INFO - 'ts_paint', 08:11:35 INFO - 'tpaint', 08:11:35 INFO - 'sessionrestore', 08:11:35 INFO - 'sessionrestore_no_auto_restore', 08:11:35 INFO - 'tabpaint']}, 08:11:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:11:35 INFO - 'ts_paint', 08:11:35 INFO - 'tpaint', 08:11:35 INFO - 'sessionrestore', 08:11:35 INFO - 'sessionrestore_no_auto_restore', 08:11:35 INFO - 'tabpaint']}, 08:11:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:11:35 INFO - 'tests': ['a11yr', 08:11:35 INFO - 'ts_paint', 08:11:35 INFO - 'tpaint', 08:11:35 INFO - 'sessionrestore', 08:11:35 INFO - 'sessionrestore_no_auto_restore', 08:11:35 INFO - 'tabpaint']}, 08:11:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:11:35 INFO - 'tests': ['a11yr', 08:11:35 INFO - 'ts_paint', 08:11:35 INFO - 'tpaint', 08:11:35 INFO - 'sessionrestore', 08:11:35 INFO - 'sessionrestore_no_auto_restore', 08:11:35 INFO - 'tabpaint']}, 08:11:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:11:35 INFO - 'tests': ['tsvgx', 08:11:35 INFO - 'tsvgr_opacity', 08:11:35 INFO - 'tart', 08:11:35 INFO - 'tscrollx', 08:11:35 INFO - 'cart', 08:11:35 INFO - 'tsvg_static']}, 08:11:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:11:35 INFO - 'tsvgr_opacity', 08:11:35 INFO - 'tart', 08:11:35 INFO - 'tscrollx', 08:11:35 INFO - 'cart', 08:11:35 INFO - 'tsvg_static']}, 08:11:35 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:11:35 INFO - 'talos_options': ['--disable-e10s'], 08:11:35 INFO - 'tests': ['tp5o']}, 08:11:35 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:11:35 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:11:35 INFO - 'talos_options': ['--disable-e10s', 08:11:35 INFO - '--xperf_path', 08:11:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:11:35 INFO - 'tests': ['tp5n']}, 08:11:35 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:11:35 INFO - 'talos_options': ['--xperf_path', 08:11:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:11:35 INFO - 'tests': ['tp5n']}}, 08:11:35 INFO - 'talos.zip': {'path': '', 08:11:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:11:35 INFO - Running post-action listener: _resource_record_post_action 08:11:35 INFO - [mozharness: 2017-03-22 15:11:35.960594Z] Finished populate-webroot step (success) 08:11:35 INFO - [mozharness: 2017-03-22 15:11:35.960703Z] Running create-virtualenv step. 08:11:35 INFO - Running pre-action listener: _resource_record_pre_action 08:11:35 INFO - Running main action method: create_virtualenv 08:11:35 INFO - Creating virtualenv /builds/slave/test/build/venv 08:11:35 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 08:11:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:11:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:11:36 INFO - Using real prefix '/tools/python27' 08:11:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:11:36 INFO - Installing distribute.............................................................................................................................................................................................done. 08:11:39 INFO - Installing pip.................done. 08:11:39 INFO - Return code: 0 08:11:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:11:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:11:39 INFO - Reading from file tmpfile_stdout 08:11:39 INFO - Output received: 08:11:39 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) 08:11:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:11:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:11:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:11:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108a50b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a53768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff80ad8bbd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10882ed30>, '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 0x108755db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108823be8>, '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.7bhy4ILqLD/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.8B38FVUj5M/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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 08:11:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:11:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:11:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7bhy4ILqLD/Render', 08:11:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:11:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:11:39 INFO - 'HOME': '/Users/cltbld', 08:11:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:11:39 INFO - 'LOGNAME': 'cltbld', 08:11:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:39 INFO - 'MOZ_NO_REMOTE': '1', 08:11:39 INFO - 'NO_EM_RESTART': '1', 08:11:39 INFO - 'PAGER': '/bin/cat', 08:11:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:11:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:39 INFO - 'PWD': '/builds/slave/test', 08:11:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:11:39 INFO - 'SHELL': '/bin/bash', 08:11:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8B38FVUj5M/Listeners', 08:11:39 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 08:11:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:11:39 INFO - 'USER': 'cltbld', 08:11:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:11:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:11:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:39 INFO - 'XPC_FLAGS': '0x0', 08:11:39 INFO - 'XPC_SERVICE_NAME': '0', 08:11:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:11:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:40 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 08:11:40 INFO - Cleaning up... 08:11:40 INFO - Return code: 0 08:11:40 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:11:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:11:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:11:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:40 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 0x108a50b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a53768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff80ad8bbd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10882ed30>, '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 0x108755db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108823be8>, '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.7bhy4ILqLD/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.8B38FVUj5M/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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 08:11:40 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 08:11:40 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 08:11:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7bhy4ILqLD/Render', 08:11:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:11:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:11:40 INFO - 'HOME': '/Users/cltbld', 08:11:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:11:40 INFO - 'LOGNAME': 'cltbld', 08:11:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:40 INFO - 'MOZ_NO_REMOTE': '1', 08:11:40 INFO - 'NO_EM_RESTART': '1', 08:11:40 INFO - 'PAGER': '/bin/cat', 08:11:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:11:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:40 INFO - 'PWD': '/builds/slave/test', 08:11:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:11:40 INFO - 'SHELL': '/bin/bash', 08:11:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8B38FVUj5M/Listeners', 08:11:40 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 08:11:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:11:40 INFO - 'USER': 'cltbld', 08:11:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:11:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:11:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:40 INFO - 'XPC_FLAGS': '0x0', 08:11:40 INFO - 'XPC_SERVICE_NAME': '0', 08:11:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:11:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:40 INFO - Downloading/unpacking psutil>=3.1.1 08:11:40 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 08:11:40 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 08:11:40 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 08:11:40 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 08:11:40 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 08:11:40 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 08:11:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:11:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:11:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:11:43 INFO - Installing collected packages: psutil 08:11:43 INFO - Running setup.py install for psutil 08:11:44 INFO - building 'psutil._psutil_osx' extension 08:11:44 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 08:11:44 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 08:11:44 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 08:11:44 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 08:11:44 INFO - building 'psutil._psutil_posix' extension 08:11:44 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 08:11:44 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:11:44 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:11:44 INFO - ^ 08:11:45 INFO - 1 warning generated. 08:11:45 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 08:11:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:11:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:11:45 INFO - Successfully installed psutil 08:11:45 INFO - Cleaning up... 08:11:45 INFO - Return code: 0 08:11:45 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:11:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:11:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:11:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108a50b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a53768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff80ad8bbd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10882ed30>, '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 0x108755db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108823be8>, '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.7bhy4ILqLD/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.8B38FVUj5M/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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 08:11:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:11:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:11:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7bhy4ILqLD/Render', 08:11:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:11:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:11:46 INFO - 'HOME': '/Users/cltbld', 08:11:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:11:46 INFO - 'LOGNAME': 'cltbld', 08:11:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:46 INFO - 'MOZ_NO_REMOTE': '1', 08:11:46 INFO - 'NO_EM_RESTART': '1', 08:11:46 INFO - 'PAGER': '/bin/cat', 08:11:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:11:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:46 INFO - 'PWD': '/builds/slave/test', 08:11:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:11:46 INFO - 'SHELL': '/bin/bash', 08:11:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8B38FVUj5M/Listeners', 08:11:46 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 08:11:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:11:46 INFO - 'USER': 'cltbld', 08:11:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:11:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:11:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:46 INFO - 'XPC_FLAGS': '0x0', 08:11:46 INFO - 'XPC_SERVICE_NAME': '0', 08:11:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:11:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:46 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:11:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:11:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:11:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:11:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:11:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:11:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:11:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:11:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:11:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:11:49 INFO - Installing collected packages: mozsystemmonitor 08:11:49 INFO - Running setup.py install for mozsystemmonitor 08:11:49 INFO - Successfully installed mozsystemmonitor 08:11:49 INFO - Cleaning up... 08:11:49 INFO - Return code: 0 08:11:49 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:11:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:11:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:11:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108a50b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a53768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff80ad8bbd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10882ed30>, '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 0x108755db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108823be8>, '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.7bhy4ILqLD/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.8B38FVUj5M/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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 08:11:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:11:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:11:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7bhy4ILqLD/Render', 08:11:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:11:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:11:49 INFO - 'HOME': '/Users/cltbld', 08:11:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:11:49 INFO - 'LOGNAME': 'cltbld', 08:11:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:49 INFO - 'MOZ_NO_REMOTE': '1', 08:11:49 INFO - 'NO_EM_RESTART': '1', 08:11:49 INFO - 'PAGER': '/bin/cat', 08:11:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:11:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:49 INFO - 'PWD': '/builds/slave/test', 08:11:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:11:49 INFO - 'SHELL': '/bin/bash', 08:11:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8B38FVUj5M/Listeners', 08:11:49 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 08:11:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:11:49 INFO - 'USER': 'cltbld', 08:11:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:11:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:11:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:49 INFO - 'XPC_FLAGS': '0x0', 08:11:49 INFO - 'XPC_SERVICE_NAME': '0', 08:11:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:11:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:49 INFO - Downloading/unpacking jsonschema==2.5.1 08:11:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:11:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:11:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:11:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:11:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:11:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:11:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:11:52 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:11:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:11:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:11:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:11:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:11:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:11:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:11:52 INFO - Downloading functools32-3.2.3-2.tar.gz 08:11:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:11:52 INFO - warning: no files found matching '*.txt' 08:11:52 INFO - no previously-included directories found matching 'build' 08:11:52 INFO - no previously-included directories found matching 'dist' 08:11:52 INFO - no previously-included directories found matching '.git*' 08:11:52 INFO - Installing collected packages: jsonschema, functools32 08:11:52 INFO - Running setup.py install for functools32 08:11:53 INFO - warning: no files found matching '*.txt' 08:11:53 INFO - no previously-included directories found matching 'build' 08:11:53 INFO - no previously-included directories found matching 'dist' 08:11:53 INFO - no previously-included directories found matching '.git*' 08:11:53 INFO - Successfully installed jsonschema functools32 08:11:53 INFO - Cleaning up... 08:11:53 INFO - Return code: 0 08:11:53 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:11: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')]} 08:11:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11: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')]} 08:11:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108a50b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a53768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff80ad8bbd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10882ed30>, '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 0x108755db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108823be8>, '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.7bhy4ILqLD/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.8B38FVUj5M/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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 08:11:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:11:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:11:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7bhy4ILqLD/Render', 08:11:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:11:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:11:53 INFO - 'HOME': '/Users/cltbld', 08:11:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:11:53 INFO - 'LOGNAME': 'cltbld', 08:11:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:53 INFO - 'MOZ_NO_REMOTE': '1', 08:11:53 INFO - 'NO_EM_RESTART': '1', 08:11:53 INFO - 'PAGER': '/bin/cat', 08:11:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:11:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:53 INFO - 'PWD': '/builds/slave/test', 08:11:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:11:53 INFO - 'SHELL': '/bin/bash', 08:11:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8B38FVUj5M/Listeners', 08:11:53 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 08:11:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:11:53 INFO - 'USER': 'cltbld', 08:11:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:11:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:11:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:53 INFO - 'XPC_FLAGS': '0x0', 08:11:53 INFO - 'XPC_SERVICE_NAME': '0', 08:11:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:11:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:53 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:11:53 INFO - Cleaning up... 08:11:53 INFO - Return code: 0 08:11:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:11: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')]} 08:11:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11: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')]} 08:11:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108a50b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a53768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff80ad8bbd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10882ed30>, '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 0x108755db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108823be8>, '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.7bhy4ILqLD/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.8B38FVUj5M/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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 08:11:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:11:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:11:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7bhy4ILqLD/Render', 08:11:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:11:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:11:53 INFO - 'HOME': '/Users/cltbld', 08:11:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:11:53 INFO - 'LOGNAME': 'cltbld', 08:11:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:53 INFO - 'MOZ_NO_REMOTE': '1', 08:11:53 INFO - 'NO_EM_RESTART': '1', 08:11:53 INFO - 'PAGER': '/bin/cat', 08:11:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:11:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:53 INFO - 'PWD': '/builds/slave/test', 08:11:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:11:53 INFO - 'SHELL': '/bin/bash', 08:11:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8B38FVUj5M/Listeners', 08:11:53 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 08:11:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:11:53 INFO - 'USER': 'cltbld', 08:11:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:11:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:11:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:53 INFO - 'XPC_FLAGS': '0x0', 08:11:53 INFO - 'XPC_SERVICE_NAME': '0', 08:11:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:11:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:53 INFO - Downloading/unpacking blobuploader==1.2.4 08:11:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:11:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:11:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:11:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:11:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:11:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:11:56 INFO - Downloading blobuploader-1.2.4.tar.gz 08:11:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:11:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:11:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:11:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:11:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:11:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:11:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:11:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:11:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:11:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:11:57 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 08:11:57 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 08:11:57 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 08:11:57 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 08:11:57 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 08:11:57 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 08:11:57 INFO - Downloading docopt-0.6.1.tar.gz 08:11:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:11:57 INFO - Installing collected packages: blobuploader, requests, docopt 08:11:57 INFO - Running setup.py install for blobuploader 08:11:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:11:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:11:57 INFO - Running setup.py install for requests 08:11:58 INFO - Running setup.py install for docopt 08:11:58 INFO - Successfully installed blobuploader requests docopt 08:11:58 INFO - Cleaning up... 08:11:58 INFO - Return code: 0 08:11:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:11:58 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')]} 08:11:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:58 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')]} 08:11:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:58 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 0x108a50b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a53768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff80ad8bbd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10882ed30>, '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 0x108755db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108823be8>, '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.7bhy4ILqLD/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.8B38FVUj5M/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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 08:11:58 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 08:11:58 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 08:11:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7bhy4ILqLD/Render', 08:11:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:11:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:11:58 INFO - 'HOME': '/Users/cltbld', 08:11:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:11:58 INFO - 'LOGNAME': 'cltbld', 08:11:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:58 INFO - 'MOZ_NO_REMOTE': '1', 08:11:58 INFO - 'NO_EM_RESTART': '1', 08:11:58 INFO - 'PAGER': '/bin/cat', 08:11:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:11:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:58 INFO - 'PWD': '/builds/slave/test', 08:11:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:11:58 INFO - 'SHELL': '/bin/bash', 08:11:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8B38FVUj5M/Listeners', 08:11:58 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 08:11:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:11:58 INFO - 'USER': 'cltbld', 08:11:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:11:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:11:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:58 INFO - 'XPC_FLAGS': '0x0', 08:11:58 INFO - 'XPC_SERVICE_NAME': '0', 08:11:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:11:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:11:58 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-ycpENK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:11:58 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-e163se-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:11:59 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-bFVn3h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:11:59 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-hofhut-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:11:59 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-idk81O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:11:59 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-S6VbTr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:11:59 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-TTbPnn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:11:59 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-jIf2Bi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:11:59 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-Vx4TGI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:11:59 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-USYjkr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:11:59 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-qG8cpH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:12:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:12:00 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-QJLKjt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:12:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:12:00 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-Es1uTf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:12:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:12:00 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-Lwz_kd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:12:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:12:00 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-ZMYTOm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:12:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:12:00 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-5drTVX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:12:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:12:00 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-1x2OJJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:12:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:12:00 INFO - Running setup.py install for manifestparser 08:12:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:12:00 INFO - Running setup.py install for mozcrash 08:12:00 INFO - Running setup.py install for mozdebug 08:12:01 INFO - Running setup.py install for mozdevice 08:12:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:12:01 INFO - Running setup.py install for mozfile 08:12:01 INFO - Running setup.py install for mozhttpd 08:12:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:12:01 INFO - Running setup.py install for mozinfo 08:12:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:12:01 INFO - Running setup.py install for mozInstall 08:12:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:12:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:12:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:12:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:12:01 INFO - Running setup.py install for mozleak 08:12:01 INFO - Running setup.py install for mozlog 08:12:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:12:02 INFO - Running setup.py install for moznetwork 08:12:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:12:02 INFO - Running setup.py install for mozprocess 08:12:02 INFO - Running setup.py install for mozprofile 08:12:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:12:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:12:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:12:02 INFO - Running setup.py install for mozrunner 08:12:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:12:02 INFO - Running setup.py install for mozscreenshot 08:12:02 INFO - Running setup.py install for moztest 08:12:03 INFO - Running setup.py install for mozversion 08:12:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:12:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:12:03 INFO - Cleaning up... 08:12:03 INFO - Return code: 0 08:12:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:12:03 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')]} 08:12:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:12:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:03 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')]} 08:12:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:12:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:03 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 0x108a50b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a53768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff80ad8bbd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10882ed30>, '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 0x108755db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108823be8>, '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.7bhy4ILqLD/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.8B38FVUj5M/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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 08:12:03 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 08:12:03 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 08:12:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7bhy4ILqLD/Render', 08:12:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:12:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:12:03 INFO - 'HOME': '/Users/cltbld', 08:12:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:12:03 INFO - 'LOGNAME': 'cltbld', 08:12:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:12:03 INFO - 'MOZ_NO_REMOTE': '1', 08:12:03 INFO - 'NO_EM_RESTART': '1', 08:12:03 INFO - 'PAGER': '/bin/cat', 08:12:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:12:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:12:03 INFO - 'PWD': '/builds/slave/test', 08:12:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:12:03 INFO - 'SHELL': '/bin/bash', 08:12:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8B38FVUj5M/Listeners', 08:12:03 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 08:12:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:12:03 INFO - 'USER': 'cltbld', 08:12:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:12:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:12:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:12:03 INFO - 'XPC_FLAGS': '0x0', 08:12:03 INFO - 'XPC_SERVICE_NAME': '0', 08:12:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:12:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:12:03 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-TwB_Rm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:12:03 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)) 08:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:12:03 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-i3AXr5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:12:03 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)) 08:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:12:03 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-ZHlQGP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:12:03 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)) 08:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:12:03 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-EJ3DyR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:12:03 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)) 08:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:12:03 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-egZU0x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:12:04 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)) 08:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:12:04 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-g1Wcyf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:12:04 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)) 08:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:12:04 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-G3AphU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:12:04 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)) 08:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:12:04 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-YHX8_o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:12:04 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)) 08:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:12:04 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-P6j_8Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:12:04 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)) 08:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:12:04 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-jXrtc1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:12:04 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)) 08:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:12:04 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-o0PqTj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:12:04 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)) 08:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:12:04 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-iQJHNA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:12:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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)) 08:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:12:04 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-yG1mxq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:12:04 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)) 08:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:12:04 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-5k9RxK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:12:04 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)) 08:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:12:04 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-PbiYtl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:12:05 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)) 08:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:12:05 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-E6_KEB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:12:05 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)) 08:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:12:05 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-5sFpuT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:12:05 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)) 08:12:05 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)) 08:12:05 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)) 08:12:05 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)) 08:12:05 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)) 08:12:05 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)) 08:12:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:12:05 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 08:12:05 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 08:12:05 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 08:12:05 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 08:12:05 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 08:12:05 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 08:12:07 INFO - Downloading blessings-1.6.tar.gz 08:12:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:12:08 INFO - Installing collected packages: blessings 08:12:08 INFO - Running setup.py install for blessings 08:12:08 INFO - Successfully installed blessings 08:12:08 INFO - Cleaning up... 08:12:08 INFO - Return code: 0 08:12:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:12:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:12:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:12:08 INFO - Reading from file tmpfile_stdout 08:12:08 INFO - Current package versions: 08:12:08 INFO - blessings == 1.6 08:12:08 INFO - blobuploader == 1.2.4 08:12:08 INFO - docopt == 0.6.1 08:12:08 INFO - functools32 == 3.2.3-2 08:12:08 INFO - jsonschema == 2.5.1 08:12:08 INFO - manifestparser == 1.1 08:12:08 INFO - mozInstall == 1.12 08:12:08 INFO - mozcrash == 1.0 08:12:08 INFO - mozdebug == 0.1 08:12:08 INFO - mozdevice == 0.49 08:12:08 INFO - mozfile == 1.2 08:12:08 INFO - mozhttpd == 0.7 08:12:08 INFO - mozinfo == 0.9 08:12:08 INFO - mozleak == 0.1 08:12:08 INFO - mozlog == 3.4 08:12:08 INFO - moznetwork == 0.27 08:12:08 INFO - mozprocess == 0.25 08:12:08 INFO - mozprofile == 0.28 08:12:08 INFO - mozrunner == 6.13 08:12:08 INFO - mozscreenshot == 0.1 08:12:08 INFO - mozsystemmonitor == 0.3 08:12:08 INFO - moztest == 0.8 08:12:08 INFO - mozversion == 1.4 08:12:08 INFO - psutil == 3.1.1 08:12:08 INFO - requests == 1.2.3 08:12:08 INFO - wsgiref == 0.1.2 08:12:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:12:08 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')]} 08:12:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:12:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:08 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')]} 08:12:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:12:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:08 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 0x108a50b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a53768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff80ad8bbd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10882ed30>, '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 0x108755db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108823be8>, '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.7bhy4ILqLD/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.8B38FVUj5M/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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 08:12:08 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 08:12:08 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 08:12:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7bhy4ILqLD/Render', 08:12:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:12:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:12:08 INFO - 'HOME': '/Users/cltbld', 08:12:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:12:08 INFO - 'LOGNAME': 'cltbld', 08:12:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:12:08 INFO - 'MOZ_NO_REMOTE': '1', 08:12:08 INFO - 'NO_EM_RESTART': '1', 08:12:08 INFO - 'PAGER': '/bin/cat', 08:12:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:12:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:12:08 INFO - 'PWD': '/builds/slave/test', 08:12:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:12:08 INFO - 'SHELL': '/bin/bash', 08:12:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8B38FVUj5M/Listeners', 08:12:08 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 08:12:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:12:08 INFO - 'USER': 'cltbld', 08:12:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:12:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:12:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:12:08 INFO - 'XPC_FLAGS': '0x0', 08:12:08 INFO - 'XPC_SERVICE_NAME': '0', 08:12:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:12:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:12:08 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)) 08:12:08 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)) 08:12:08 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)) 08:12:08 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)) 08:12:08 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)) 08:12:08 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)) 08:12:08 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)) 08:12:08 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)) 08:12:08 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)) 08:12:08 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)) 08:12:08 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)) 08:12:08 INFO - Cleaning up... 08:12:08 INFO - Return code: 0 08:12:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:12:08 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')]} 08:12:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:12:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:08 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')]} 08:12:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:12:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:08 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 0x108a50b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a53768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff80ad8bbd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10882ed30>, '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 0x108755db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108823be8>, '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.7bhy4ILqLD/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.8B38FVUj5M/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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 08:12:08 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 08:12:08 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 08:12:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7bhy4ILqLD/Render', 08:12:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:12:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:12:08 INFO - 'HOME': '/Users/cltbld', 08:12:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:12:08 INFO - 'LOGNAME': 'cltbld', 08:12:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:12:08 INFO - 'MOZ_NO_REMOTE': '1', 08:12:08 INFO - 'NO_EM_RESTART': '1', 08:12:08 INFO - 'PAGER': '/bin/cat', 08:12:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:12:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:12:08 INFO - 'PWD': '/builds/slave/test', 08:12:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:12:08 INFO - 'SHELL': '/bin/bash', 08:12:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8B38FVUj5M/Listeners', 08:12:08 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 08:12:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:12:08 INFO - 'USER': 'cltbld', 08:12:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:12:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:12:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:12:08 INFO - 'XPC_FLAGS': '0x0', 08:12:08 INFO - 'XPC_SERVICE_NAME': '0', 08:12:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:12:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:12:09 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:12:09 INFO - Cleaning up... 08:12:09 INFO - Return code: 0 08:12:09 INFO - Running post-action listener: _resource_record_post_action 08:12:09 INFO - Running post-action listener: _start_resource_monitoring 08:12:09 INFO - Starting resource monitoring. 08:12:09 INFO - [mozharness: 2017-03-22 15:12:09.164431Z] Finished create-virtualenv step (success) 08:12:09 INFO - [mozharness: 2017-03-22 15:12:09.165395Z] Running install step. 08:12:09 INFO - Running pre-action listener: _resource_record_pre_action 08:12:09 INFO - Running main action method: install 08:12:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:12:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:12:09 INFO - Reading from file tmpfile_stdout 08:12:09 INFO - Detecting whether we're running mozinstall >=1.0... 08:12:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:12:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:12:09 INFO - Reading from file tmpfile_stdout 08:12:09 INFO - Output received: 08:12:09 INFO - Usage: mozinstall [options] installer 08:12:09 INFO - Options: 08:12:09 INFO - -h, --help show this help message and exit 08:12:09 INFO - -d DEST, --destination=DEST 08:12:09 INFO - Directory to install application into. [default: 08:12:09 INFO - "/builds/slave/test"] 08:12:09 INFO - --app=APP Application being installed. [default: firefox] 08:12:09 INFO - mkdir: /builds/slave/test/build/application 08:12:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:12:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 08:12:29 INFO - Reading from file tmpfile_stdout 08:12:29 INFO - Output received: 08:12:29 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 08:12:29 INFO - Running post-action listener: _resource_record_post_action 08:12:29 INFO - [mozharness: 2017-03-22 15:12:29.433611Z] Finished install step (success) 08:12:29 INFO - [mozharness: 2017-03-22 15:12:29.433783Z] Running run-tests step. 08:12:29 INFO - Running pre-action listener: _resource_record_pre_action 08:12:29 INFO - Running main action method: run_tests 08:12:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:12:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:12:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:12:29 INFO - 2017-03-22 08:12:29.448 screenresolution[1630:7582] starting screenresolution argv=screenresolution get 08:12:29 INFO - 2017-03-22 08:12:29.451 screenresolution[1630:7582] Display 0: 1600x1200x32@60 08:12:29 INFO - 2017-03-22 08:12:29.457 screenresolution[1631:7585] starting screenresolution argv=screenresolution list 08:12:29 INFO - Available Modes on Display 0 08:12:29 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:12:29 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:12:29 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:12:29 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:12:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:12:29 INFO - Intel Iris: 08:12:29 INFO - Chipset Model: Intel Iris 08:12:29 INFO - Type: GPU 08:12:29 INFO - Bus: Built-In 08:12:29 INFO - VRAM (Dynamic, Max): 1536 MB 08:12:29 INFO - Vendor: Intel (0x8086) 08:12:29 INFO - Device ID: 0x0a2e 08:12:29 INFO - Revision ID: 0x0009 08:12:29 INFO - Displays: 08:12:29 INFO - Display: 08:12:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:12:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:12:29 INFO - Display Serial Number: 1600x1200 60 08:12:29 INFO - Main Display: Yes 08:12:29 INFO - Mirror: Off 08:12:29 INFO - Online: Yes 08:12:29 INFO - Rotation: Supported 08:12:29 INFO - Return code: 0 08:12:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:12:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:12:29 INFO - Python 2.7.3 08:12:29 INFO - Return code: 0 08:12:29 INFO - grabbing minidump binary from tooltool 08:12: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')]} 08:12:29 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 0x10882ed30>, '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 0x108755db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108823be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:12:29 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 08:12:29 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 08:12:29 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 08:12:29 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:12:29 INFO - Return code: 0 08:12:29 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:12:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:12:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:12:29 INFO - ENV: RUST_BACKTRACE is now 1 08:12:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:12:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:12:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Pe-aGIinRvaB-MuJm7ikhQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0191', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 08:12:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Pe-aGIinRvaB-MuJm7ikhQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0191 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 08:12:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7bhy4ILqLD/Render', 08:12:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:12:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:12:29 INFO - 'HOME': '/Users/cltbld', 08:12:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:12:29 INFO - 'LOGNAME': 'cltbld', 08:12:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:12:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:12:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:12:29 INFO - 'MOZ_NO_REMOTE': '1', 08:12:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:12:29 INFO - 'NO_EM_RESTART': '1', 08:12:29 INFO - 'PAGER': '/bin/cat', 08:12:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:12:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:12:29 INFO - 'PWD': '/builds/slave/test', 08:12:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:12:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:12:29 INFO - 'RUST_BACKTRACE': '1', 08:12:29 INFO - 'SHELL': '/bin/bash', 08:12:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8B38FVUj5M/Listeners', 08:12:29 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 08:12:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:12:29 INFO - 'USER': 'cltbld', 08:12:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:12:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:12:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:12:29 INFO - 'XPC_FLAGS': '0x0', 08:12:29 INFO - 'XPC_SERVICE_NAME': '0', 08:12:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:12:29 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Pe-aGIinRvaB-MuJm7ikhQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0191', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 08:12:30 INFO - mozversion application_buildid: 20170322062735 08:12:30 INFO - mozversion application_changeset: 27f7aadeea833eca8c9c0e24c858f798e4d6fdd8 08:12:30 INFO - mozversion application_display_name: Nightly 08:12:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:12:30 INFO - mozversion application_name: Firefox 08:12:30 INFO - mozversion application_remotingname: firefox 08:12:30 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:12:30 INFO - mozversion application_vendor: Mozilla 08:12:30 INFO - mozversion application_version: 55.0a1 08:12:30 INFO - mozversion platform_buildid: 20170322062735 08:12:30 INFO - mozversion platform_changeset: 27f7aadeea833eca8c9c0e24c858f798e4d6fdd8 08:12:30 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:12:30 INFO - mozversion platform_version: 55.0a1 08:12:30 INFO - using testdate: 1490195550 08:12:30 INFO - actual date: 1490195550 08:12:30 INFO - starting webserver on 'localhost:49245' 08:12:30 INFO - SUITE-START | Running 2 tests 08:12:30 INFO - TEST-START | dromaeo_css 08:12:30 INFO - operating with platform_type : mac_ 08:12:30 INFO - Initialising browser for dromaeo_css test... 08:12:30 INFO - TEST-INFO | started process 1641 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/tmpd8KgQE/profile http://localhost:49245/getInfo.html) 08:12:33 INFO - PID 1641 | 2017-03-22 08:12:33.215 plugin-container[1643:7773] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4a3f, name = 'com.apple.tsm.portname' 08:12:33 INFO - PID 1641 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:12:33 INFO - PID 1641 | 2017-03-22 08:12:33.218 plugin-container[1643:7773] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9613, name = 'com.apple.CFPasteboardClient' 08:12:33 INFO - PID 1641 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:12:33 INFO - PID 1641 | 2017-03-22 08:12:33.218 plugin-container[1643:7773] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:12:33 INFO - PID 1641 | __metrics Screen width/height:1600/1200 08:12:33 INFO - PID 1641 | colorDepth:24 08:12:33 INFO - PID 1641 | Browser inner width/height: 1024/689 08:12:33 INFO - PID 1641 | __metrics 08:12:33 ERROR - PID 1641 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3350: TypeError: this.tabs is undefined 08:12:34 INFO - TEST-INFO | 1641: exit 0 08:12:34 INFO - Browser initialized. 08:12:34 INFO - Running cycle 1/1 for dromaeo_css test... 08:12:34 INFO - TEST-INFO | started process 1644 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/tmpd8KgQE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:12:36 INFO - PID 1644 | 2017-03-22 08:12:36.748 plugin-container[1645:7908] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4747, name = 'com.apple.tsm.portname' 08:12:36 INFO - PID 1644 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:12:36 INFO - PID 1644 | 2017-03-22 08:12:36.749 plugin-container[1645:7908] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 08:12:36 INFO - PID 1644 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:12:36 INFO - PID 1644 | 2017-03-22 08:12:36.749 plugin-container[1645:7908] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:12:46 INFO - PID 1644 | RSS: Main: 227852288 08:12:46 INFO - PID 1644 | 08:15:50 INFO - PID 1644 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49245/tests/dromaeo/cssquery-ext.html) 08:15:52 INFO - PID 1644 | RSS: Main: 250470400 08:15:52 INFO - PID 1644 | 08:17:34 INFO - PID 1644 | ************************* 08:17:34 INFO - PID 1644 | A coding exception was thrown and uncaught in a Task. 08:17:34 INFO - PID 1644 | 08:17:34 ERROR - PID 1644 | Full message: TypeError: NetworkError when attempting to fetch resource. 08:17:34 INFO - PID 1644 | Full stack: 08:17:34 INFO - PID 1644 | ************************* 08:18:54 INFO - PID 1644 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-ext.html (next: http://localhost:49245/tests/dromaeo/cssquery-jquery.html) 08:18:55 INFO - PID 1644 | RSS: Main: 259899392 08:18:55 INFO - PID 1644 | 08:21:57 INFO - PID 1644 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49245/tests/dromaeo/cssquery-mootools.html) 08:21:57 INFO - PID 1644 | RSS: Main: 270983168 08:21:57 INFO - PID 1644 | 08:24:59 INFO - PID 1644 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49245/tests/dromaeo/cssquery-prototype.html) 08:25:00 INFO - PID 1644 | RSS: Main: 263278592 08:25:00 INFO - PID 1644 | 08:28:03 INFO - PID 1644 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49245/tests/dromaeo/cssquery-yui.html) 08:28:04 INFO - PID 1644 | RSS: Main: 273993728 08:28:04 INFO - PID 1644 | 08:31:06 INFO - PID 1644 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-yui.html (next: http://localhost:49245/tests/dromaeo/cssquery-dojo.html) 08:31:07 INFO - PID 1644 | RSS: Main: 267972608 08:31:07 INFO - PID 1644 | 08:31:07 INFO - PID 1644 | __start_tp_report 08:31:07 INFO - PID 1644 | _x_x_mozilla_page_load 08:31:07 INFO - PID 1644 | _x_x_mozilla_page_load_details 08:31:07 INFO - PID 1644 | |i|pagename|runs| 08:31:07 INFO - PID 1644 | |0;dojo.html;3545.645435456453;3555.9466608000885;3604.5674519057716;3624.2751449710063;3635.3456377851994;4928.950710492894;6118.969405152968;6139.1712118864;6140.631562106266;6165.414285642868;4848.272759086139;6120.904292401153;6171.845703857406;6175.1663525424165;6188.969055154729;5427.945720542803;5546.168074788774;5584.832455026356;5621.943780562204;5668.886622267552;3981.9402708959387;4675.602573781216;5075.238714192882;5679.943200567983;5710.77156913723;5464;5625.71871406428;5635.1828984797385;5666.773329066853;5678.886422271552;5504.256925315071;5511.448855114497;5532.806351777709;5535.806246781343;5537.556995440355;5504.256925315071;5541.9168712469345;5551.333839939233;5574.080276754331;5628.43715628438;4756.9286460703115;6080.118382834465;6165.352637972993;6175.042868355412;6184.81445556634;6295.905561416583;6639.634820084893;6675.566088204251;6676.632785196813;6683.2982536833415;6566.67166641666;6652.767153149665;6701.128853249046;6743.696533655997;6764.425023872976;5180.844574662766;6236.532260080512;6280.842978925518;6298.4331410172845;6309.684515774285;5888.558358123158;6500.089987401768;6819.931800681929;6850.38346548813;6911.89632155518;6364.045393191059;6399.584027038228;6420.357964203636;6532.967335163294;6562.376574225441;6685.799426017227;6701.832454188587;6711.899321510181;6733.46132309414;6740.595564266159;6539.8555252830565;6561.3438656134;6601.504887133484;6617.172853393326;6631.900521492182;6403.199600049994;6481.384268494579;6573.769918052845;6607.438367738796;6666.466682665375;5308.814191503279;5326.9467305327225;5333.200019997032;5337.759800808895;5356.625036247503;4722.905541889143;4756.286557016406;4769.35613692154;4772.069446457907;4810.230363141881;6181.629102253879;6244.968775156095;6303.558750887486;6338.683065846689;6355.745770169141;6767;6784.491163162783;6793.082933803972;6797.728090876409;6817.761378351734;6246.614015119506;6357.300696923335;6382.5851319665;6393.904091438632;6400.167978162902;4908.828191013297;5771.942280577225;5796.507296879812;5827.94172058274;5949.2266005419015;6795.1845778506895;6876.587404755731;6881.862362752817;6898.724051037902;6911.930880691129;6439.06633538125;6732.394084532416;6754.696038678173;6754.966225168842;6791;6612.966935165294;6698;6807.693653785691;6875.346842049998;6883.724651013903;6447.967760161169;6655.933440665532;6671.332866713484;6671.733130674718;6699.09562209115;6551.639659818756;6615.17310336208;6637.037629543593;6699.43054840344;6741.932580674326;6524.869502610016;6527.281998980014;6540.37866402691;6552.24649165333;6575.80272591823;6462.612243265231;6485.897397442352;6503.544751867324;6551.050097735706;6553.4101930826455;6117.449429551361;6145.125736650186;6271.466925311217;6274.686265686789;6402.35976402356;5692.601517893708;6514.055461957895;6550.082988381535;6568.244651865097;6580.605163690194;5319.122344813217;6236.18929539157;6395.488360931021;6421.133147025092;6442.677866106769 08:31:07 INFO - PID 1644 | |1;ext.html;754.2156157596097;776.6776787633131;829.4691397505595;1291.502771432998;1293.644247831846;28766.712332876665;37843.81078094613;37854.8107259464;37922.24155516891;37943.343965922395;36917.446238306446;37354;37444.442777936056;37452.25095498088;37484.62515374846;7900.288973992339;8060.274575288223;8432.40973131881;8653.69712060078;8654.350923680719;8601.827963440728;8661.263792577638;8719.60761765719;8727.301815854747;8732.607032683512;8659.09079546648;8676.566171691422;8725.083866194022;8744.825103497926;8760.956195219014;8703.869441958375;8720.563971801384;8732.257758090507;8750.781230469225;8761.036286008533;7326.597037162954;7916.129225785159;8070.668339723998;8567;8626.784330391727;37168;37345.439818402745;37380.81309593435;37503.62496375056;37534;2981.95527067092;3016.8491575421363;3032.348045170299;3035.165329534396;3045.512717965137;23443.94502247403;26557.867210664015;27495.587566186525;27860.303492412648;28076.017339393024;2764.4747497975322;2765.769232691453;2772.126780064273;2774.4173723518084;2793.106206014076;227951;232624;236526;331171;331433;35942.460863086555;44805;44947.426840061096;45136.77431612887;45235.773821130686;42761;46611.30083048757;47075.293870591966;47281.5271847284;47323.76338118287;12322.876771232352;13874.167549946833;14262.786058209134;14290.785638215228;14318;11494.655160345203;11694.47374868133;11736.354500502384;11764.88235117655;11767.646970590724;13581.592552223448;13594;13616.86383136156;13618.727625447635;13772.311384430739;5095.592352611782;5971.343152253248;6031.698415079229;6039.78860739872;6048.637081775019;960.9951950240204;973.7730459620788;976.7411635916487;979.6816034788723;1020.4489575629077;20116.39650810478;23852;23870.045198192227;23954.845116954664;24166.516669666507;1045.4041196517912;1057.3127467146262;1101.2566517600587;1101.7961677089763;1113.507899414788;11219.775604487864;11368.658940231806;11848.644540663794;12339.444724987397;12415.75168496625;393181;448581;457808;462448;462656;51326.74336628293;51871.74064129731;52127.739361303706;52364;52427;1345.79140233264;1487.4273404739254;1489.8137732783184;1497.3262032085604;1500.9774853377207;16970.40603578869;22084.88957555202;22337.32988010362;22905.350860582304;22974.77025229726;36609;36720.81639591785;36841.07897302589;36897.63102368942;36959;452900.73549633357;453194;453384;455467;456734;25796;31458.89893853704;32645.673543264264;33455.83272083624;33652.66347336593;34651;42247.78876105723;42772.358414624425;42791;43757;30407.54388684127;31059.602317895296;34960.30079398449;35024.64975350214;35894.64105358913;31756.6824331763;34445.82777086098;35251.64748352586;35671.64328356787;36080.639193608775;35030.824845875606;35447;35801.64198357983;35865.28269434649;35916.82041589775;26415;31504.527432088078;31741.889033883705;31793.523097154022;31827;22917.427064323525;23599.41001474977;23702.881485593152;23917.28248152558;24350.39124021843 08:31:07 INFO - PID 1644 | |2;jquery.html;396.76590811421266;428.5050766364846;431.2345586583815;438.1915366149454;456.1720477333639;20784.48038799031;21616.567668646636;21689.7225791292;22157.224497142604;22528;22399.55200895981;22568.66147007796;23197;23221.419464513394;23518.294451166494;6228.972219583786;6288.496920246369;6490.707918143671;6491.642959637218;6493.123428337185;6136.509079273647;6346.365363463663;6347.206599175103;6349.809505714836;6353.555251132422;5677.148427735852;5891.764329426818;6283.3088360280335;6300.180976473052;6301.936980630181;4477.485089214733;6221.222347206599;6303.779367722108;6314.463270622003;6320.241571011485;4724.6928949618505;5572.3034620672415;5618;5637.3517045539875;5645.661260324394;27069.917203311845;27202.72797272022;27536.44927101467;27700.584491232647;27959.58060629092;2038.5820906714089;2046.467918341227;2049.5286084200716;2050.29264903608;2079.105984426696;16003;16506;16523.83476165235;16804.915975420045;17221.951243790936;1652.6612044530843;1685.1489997551157;1689.8817082804208;1704.2416124824458;1716.364944970369;143472;147430;158152;163465.3653463462;165079.17460412742;10419.791604167875;11940.88059119415;12533.185342952678;12575;12804.231746095264;16136.435224767078;16514.174291285388;16531.91734041322;16535.106356387583;16544.50366489007;8797.340199485065;9020.691999660145;9104.408213466104;9114.954425227832;9176.724698259062;7203.459740519482;8622.353323500636;8626.353023523261;8657.696980605648;8761.430507017023;6645.534812563171;7840.84318313642;7845.843083138306;8013.238742319587;8026.558539280396;2120.2155202575145;2209.149477451193;2210.767869373725;2215.268961242786;2398.2085911649115;927.420362273579;931.7065124485765;955.6320816485564;956.8038552096804;968.138356862393;17648.382306619464;19897.104630291673;20801.79198208029;21026.78973210279;21057.57884842325;953.4755884263766;966.5988614724811;969.7721035556639;982.3958265666706;992.7071513903416;10277;10520.368777873353;10945.288556243819;10971.615993440191;11003.449827508593;638376;654452;680151;685916;687659;153937;154498;155384;156328.21835890747;159210;1119.630521927762;1153.9365334906493;1181.6927598824195;1182.43243243242;1216.0332535634016;20356.79643203549;21123.683144753148;21221.89389053045;21607.45981350479;22081.779182208615;64794.67602661956;65111;65464.67267663631;65892.67053664701;65964.34035659581;84357.3128537438;85857;86975.65121743761;87379.56310218408;87816.0965513107;8586;8610.698625548326;8826.161514656098;8918.10818918103;8945.37382383253;13862.168269903837;13863.584092477242;14024.649383765487;14306.713865722835;14398;10433.895661043292;10984.340939543654;11551.595694150665;11840.407979600814;11989.34058626784;9644.517774111408;9869.901300986898;10734.785304294026;11822.290662560274;11949.820752688544;10586.206034547593;11132.833007505056;11672.941635291769;11748.412579371168;12085;8758.693445729368;8909.643614255358;8932.732018039469;9073.727788166365;9077.273818094669;10172.033656802592;11439.771204576029;11938.28370297785;11961.880381196424;12168.756624867276 08:31:07 INFO - PID 1644 | |3;mootools.html;1198.3169593331802;1264.7407281507292;1313.1989486413293;1414.5402744108167;1421.438531779947;9518.714973478587;10076.445795481264;10333.948330258347;10688.679339619814;10873.619423320186;10700.197485188603;10845.945770271157;10913.454327283644;10930;10947.507362168702;2033.7661168965537;2418.794402475787;2465.050955382173;2465.852048877064;2470.086068154785;1984.7419835421374;2399.7960173385195;2457.680501534798;2461.716902556202;2462.076721229539;2008.317172161465;2393.9281821545296;2430.331658793837;2436.2325867351815;2441.5727247731666;2378.2270762002245;2402.870650794124;2405.615101583756;2406.723226828911;2427.647991041298;2353.9646905296436;2383.5232953409213;2432.3067925641285;2445.3642053066333;2452.9141480048293;10752.408617526033;10859.239853210278;10985.61550345734;11002.834957475645;11023.779524409547;5769.730659254958;5897.0859516774535;6172.259328880518;6403.711832967528;6412.487001039905;3954.3277642800504;3988.700847436454;4031.21391328691;4059.147579008412;4108.548059713429;1185.9407029648482;1510.1090356689606;1547.667251540913;1567.9451219207274;1633.1426001349269;11180.608678696288;13352.732945341137;14981.02623329491;14999.475018374305;15132.167730774803;5459.2902922619805;5719.428057194331;5723.084306510938;5742.3396309424115;5746.913796293059;12531.93734031324;12610.054245931591;12613.810792838114;12625.936870315589;12627.684307892192;5161.638685292069;6304.590201636879;6310.337414571496;6313.147725057151;6348.238211414659;5714.457126572969;5717.885642287131;5801.7099145042575;5801.970990145022;5848.3274423441;4452.9109417812115;4469.41897553316;4509.346144808985;4522.29904364824;4532.546745325507;1398.4685819388567;1438.6331485471137;1455.3087283540233;1465.6482444213311;1468.2511918921214;641.900505421651;772.5750837039606;798.9920100799034;799.7960520067462;831.7005877883956;6139.3730661373875;6378.202724659418;6731.158605174353;6802.387785099365;6919.550229235184;715.4026387966106;892.3218354050967;898.8247291778172;908.9454632722058;920.1580553793204;4153.709240353146;4166.354215096665;4227.408162857202;4299.548547402478;4333.653307735373;13401.329933503286;13843;13850.930745346208;13852.238126902916;13895.722085558435;13661.248631325372;13661.658458538615;13776.311184440938;13778.242196679279;13808.378622961991;10032.1472674822;10285.22860785444;10331.845022324671;10352.844707329396;10362.792744145225;5438.537724293479;6038.426349496791;6095.2685677718955;6192.349803270772;6300.369963003663;11122.833157502482;12430.751384972069;12568;12577.119601627799;12586.118971671895;11710.473028713557;11971.880281197426;12126.878731212928;12488.625341239778;12720.87279127197;7693.538387696756;8334.249917507454;8361.749147525585;8459.91540084616;8462.957685211535;9524.380915240487;10039.4478303694;10047.196224301892;10101.79796404053;10136.493175341056;7529.397648188023;8458.562044452336;8798.780030499032;8817.294616430541;9009.81980360376;8518.190771876662;8560;8608.225259726654;8654.82690346202;8744.606492707717;7640.656170472231;7662.578558179353;7672.923270767221;7733.221359087329;7733.994580704472;4796.35249241348;5714.171445140514;5802.216700745345;5891.1457838614015;5933.842900634335;5598.776048958159;5652.152177173457;5661.943380566142;5827.155062515827;6065.7573697053385 08:31:07 INFO - PID 1644 | |4;prototype.html;319.3086966717058;394.35129212445526;400.9355162044772;401.51416785689315;403.73555321264564;5852.190948344797;6446.258680251773;6464.9009668356375;6465.127207826942;6489.643069631168;5314.3091398118195;5962.582619216657;6067.178761875727;6320.462760665349;6345.49236061114;4553.521880202581;4870.464248932623;4883.536064073925;4894.4371397289415;4898.681585696936;4227.8308867645255;4723.5512626300615;4823.469418363977;4927.162382395001;4941.654084214107;4061.776602286873;4662.766861656921;4815.253635686474;4878;4899.289603007562;3902.278078555448;4834.709917404932;4835.588974937117;4841.152798260308;4858.611311095104;3491.476278558211;3523.700485458739;4269.658427325838;4312.525622181557;4327.307630779092;5880.470757631791;5907.438793314671;6153;6202.503799696058;6206.2862770781485;5647.745851436695;5738.684372359518;5754.913676294859;5777.711114444261;5788.5369170466265;6447.677616119222;6596.60420374779;6825.976103584452;6950.339717726808;6950.409215216712;3614.0845351963503;4807.399075115611;4827.444843842933;4831.541003604652;4834.854954351375;6484.865148598977;6831.096783866837;6863.2793556676825;6986.161660600709;7104.6447677615915;4285.935710964338;4767.785449654774;4957.4794646561595;4971.975140124277;5004.149294619923;4213.452251207324;5054.418741844662;5065.898682026413;5082.25558198576;5096.974515127475;4837.2260438329695;5472.002719007533;5640.323161220597;5706.771729130871;5738;6822.147231596051;6825.624590647562;6836.555623884432;6905.309469053054;6935.202451718016;1499.6475828180369;1523.4820161145265;1527.4043123181968;1686.4434736536914;1742.7647267618709;1033.2095946600857;1093.4040947683532;1109.3177695717077;1193.5941779794912;1198.1253684810138;5422.43064478232;5646.068398714248;6098.878022439526;6408.903866442007;6495.610263384212;5766.799426318434;6450.516381232249;7064.752733654297;7093;7096.077509923677;6354.474926017722;6444.387783160592;6454.806355809334;6457.354264573505;6483.7082331295205;3145.9303836695176;3239.5140728890856;3348.0783248624484;3439.7764145330975;3651.707863370924;6218.347073557302;7106.680199391039;7196.172440169447;7232.493725439274;7247.5720633588335;5432.266644003009;5849.064149736022;5876.559258055663;6634.303398143222;7244;5995.481897603017;6165;6266;7193.208747037717;7224.277572242734;6931.93068069333;7005.404540613901;7035.753748618774;7043.788686339418;7088.109204648776;6231.781887633911;6493.545451818327;6624.933750662624;6839.555428897106;6843.828904277433;5312.5484333832055;6148.50811935053;6240.251169859646;7079.469039822137;7204.308596208936;3854.5759966404235;3916.4908561886773;4072.7759973200573;4342.240107981153;4950;5979.182037528277;6541.233866856018;6799.796006119825;6934.237233904166;6936.930630693831;5872.032868988937;6694.933050669626;6703.966480167568;6727.697253623696;6739.427148692416;6394.360563943568;6507.869842603027;6591.835204119935;6622.933770662425;6731.596104233761;5732;6187.388628502141;6538.907549584087;6574.638394888327;6589.24223714279;5532.944670553243;6131.54013449002;6426;6589.47284217271;6804.353586409283;6272.874542509216;6503.577267477788;6534.379233972765;6580.638064906476;6661.900071498834 08:31:07 INFO - PID 1644 | |5;yui.html;628.7139351595025;706.3148745716657;721.4228617106313;721.9927800721991;739.3309055304948;17291.481255562336;17699.380521681745;18026.81973180268;18279.45161645151;18281.08594570271;16700.498985030437;16716.996980181197;17045.14774261285;17165.399211027587;17224.741628875578;941.7410212191668;967.9903200967971;970.587500312368;970.8349580571285;973.1339108193678;932.4265576670333;960.4093482508242;961.6105477281677;972.2659392158945;978.931474796761;993.9403635781877;1009.5860697114184;1010.8433192855119;1011.9797604047915;1013.7871047080122;1010.9292349535499;1014.5130337437997;1014.6854475112701;1016.8678071850612;1017.8218811707995;747.7906186267853;756.6405957170355;758.0902916500222;758.5979430901631;760.2169765141857;13282.402291896888;15846.890717649769;16565.83434165655;16784.916075419667;17013.89409688366;13654.931725341408;13969.511067112602;13996.230207338593;14107.65607536322;14156.009079364449;10326.070653641133;10769.784604307948;10942.781144377148;11168.497417616227;11748.588799392066;2701.9729802702113;2770.4182121754457;2961.318896653782;2989.4618968585646;2994.895178668736;105085;106559.4672026635;107706.384404234;120145.62504035486;120492;11209.71975700614;11259.324440533594;11429.485673144729;11747.17769756126;11804.055675546108;24582.262532123706;25078.24765257045;25156.496870062496;25158.371040724127;25231.873840631048;7595.392368610498;7621.69513219465;7777.455578109591;8007.678733008988;8019.83960320802;4055.614716601918;4086.3870419436726;4121.4848143982;4166.145940082337;4187.895302617459;3394.405978953673;3515.9472607910902;4146.626803587692;4203.285441474956;4246;788.4993029426241;791.8574656561874;797.493591569346;798.4849771897094;803.9075506316732;453.71869440946824;496.27543786072016;567.5402923631872;573.2089716191629;575.545319197829;8992.640294388282;9881.654142104991;9942.502874856229;10140.797184056277;10307.84538231927;571.2773341722724;573.5211098732522;576.7923547522888;590.3181824992141;597.2206270816539;3724.625242020814;4543.568361005699;4674.182018146811;4745.691530050535;4777.187878060738;95398.52300738591;98933.50533247432;100386;101177;103076;57797.71101144468;65256;65353.34646653473;70162.2983770166;73383;53604.46395536073;57940;66686;70206.29793701998;70810.64594676993;10531.526081326205;10681.570719330553;10787.67636970892;10862.34825910448;10869.239153259196;35371.82314088413;35599;37451.43822842605;37653;38638.613613864625;48516.272255915486;48651;49473.50526494833;49726.502734973634;50004;13400.865991339962;13410;13505.459781608626;13947.51183708606;14103.2948352584;14086.647833804236;14455.566333010027;14466.493672721404;14486.348114334669;14666.56000319992;13474.865251347754;13597.86402135966;13600.183988960694;13758.036937414285;14085.15489070659;13307.80038299407;13510.392032358372;13541.255230961997;13950.707698745875;14050.578482645536;12987.675308116995;13006.674833129247;13074.869251307366;13140.831762759037;13551.119177253448;10898;11075.944620276847;11093.722656933642;11566.190366674253;11722.179447438597;9625.32622716403;9792.804143917225;10932.398718070583;11172;11231.326120432801 08:31:07 INFO - PID 1644 | __end_tp_report 08:31:07 INFO - PID 1644 | __start_cc_report 08:31:07 INFO - PID 1644 | _x_x_mozilla_cycle_collect,417 08:31:07 INFO - PID 1644 | __end_cc_report 08:31:07 INFO - PID 1644 | __startTimestamp1490196667211__endTimestamp 08:31:07 INFO - PID 1644 | 08:31:07 INFO - PID 1644 | ------- Summary: start ------- 08:31:07 INFO - PID 1644 | Number of tests: 6 08:31:07 INFO - PID 1644 | 08:31:07 INFO - PID 1644 | [#0] dojo.html Cycles:165 Average:6104.45 Median:6382.59 stddev:745.90 (11.7%) stddev-sans-first:720.67 08:31:07 INFO - PID 1644 | Values: 3545.6 3555.9 3604.6 3624.3 3635.3 4929.0 6119.0 6139.2 6140.6 6165.4 4848.3 6120.9 6171.8 6175.2 6189.0 5427.9 5546.2 5584.8 5621.9 5668.9 3981.9 4675.6 5075.2 5679.9 5710.8 5464.0 5625.7 5635.2 5666.8 5678.9 5504.3 5511.4 5532.8 5535.8 5537.6 5504.3 5541.9 5551.3 5574.1 5628.4 4756.9 6080.1 6165.4 6175.0 6184.8 6295.9 6639.6 6675.6 6676.6 6683.3 6566.7 6652.8 6701.1 6743.7 6764.4 5180.8 6236.5 6280.8 6298.4 6309.7 5888.6 6500.1 6819.9 6850.4 6911.9 6364.0 6399.6 6420.4 6533.0 6562.4 6685.8 6701.8 6711.9 6733.5 6740.6 6539.9 6561.3 6601.5 6617.2 6631.9 6403.2 6481.4 6573.8 6607.4 6666.5 5308.8 5326.9 5333.2 5337.8 5356.6 4722.9 4756.3 4769.4 4772.1 4810.2 6181.6 6245.0 6303.6 6338.7 6355.7 6767.0 6784.5 6793.1 6797.7 6817.8 6246.6 6357.3 6382.6 6393.9 6400.2 4908.8 5771.9 5796.5 5827.9 5949.2 6795.2 6876.6 6881.9 6898.7 6911.9 6439.1 6732.4 6754.7 6755.0 6791.0 6613.0 6698.0 6807.7 6875.3 6883.7 6448.0 6655.9 6671.3 6671.7 6699.1 6551.6 6615.2 6637.0 6699.4 6741.9 6524.9 6527.3 6540.4 6552.2 6575.8 6462.6 6485.9 6503.5 6551.1 6553.4 6117.4 6145.1 6271.5 6274.7 6402.4 5692.6 6514.1 6550.1 6568.2 6580.6 5319.1 6236.2 6395.5 6421.1 6442.7 08:31:07 INFO - PID 1644 | 08:31:07 INFO - PID 1644 | [#1] ext.html Cycles:180 Average:52000.40 Median:35833.46 stddev:106603.01 (297.5%) stddev-sans-first:106832.63 08:31:07 INFO - PID 1644 | Values: 754.2 776.7 829.5 1291.5 1293.6 28766.7 37843.8 37854.8 37922.2 37943.3 36917.4 37354.0 37444.4 37452.3 37484.6 7900.3 8060.3 8432.4 8653.7 8654.4 8601.8 8661.3 8719.6 8727.3 8732.6 8659.1 8676.6 8725.1 8744.8 8761.0 8703.9 8720.6 8732.3 8750.8 8761.0 7326.6 7916.1 8070.7 8567.0 8626.8 37168.0 37345.4 37380.8 37503.6 37534.0 2982.0 3016.8 3032.3 3035.2 3045.5 23443.9 26557.9 27495.6 27860.3 28076.0 2764.5 2765.8 2772.1 2774.4 2793.1 227951.0 232624.0 236526.0 331171.0 331433.0 35942.5 44805.0 44947.4 45136.8 45235.8 42761.0 46611.3 47075.3 47281.5 47323.8 12322.9 13874.2 14262.8 14290.8 14318.0 11494.7 11694.5 11736.4 11764.9 11767.6 13581.6 13594.0 13616.9 13618.7 13772.3 5095.6 5971.3 6031.7 6039.8 6048.6 961.0 973.8 976.7 979.7 1020.4 20116.4 23852.0 23870.0 23954.8 24166.5 1045.4 1057.3 1101.3 1101.8 1113.5 11219.8 11368.7 11848.6 12339.4 12415.8 393181.0 448581.0 457808.0 462448.0 462656.0 51326.7 51871.7 52127.7 52364.0 52427.0 1345.8 1487.4 1489.8 1497.3 1501.0 16970.4 22084.9 22337.3 22905.4 22974.8 36609.0 36720.8 36841.1 36897.6 36959.0 452900.7 453194.0 453384.0 455467.0 456734.0 25796.0 31458.9 32645.7 33455.8 33652.7 34651.0 42247.8 42772.4 42791.0 43757.0 30407.5 31059.6 34960.3 35024.6 35894.6 31756.7 34445.8 35251.6 35671.6 36080.6 35030.8 35447.0 35801.6 35865.3 35916.8 26415.0 31504.5 31741.9 31793.5 31827.0 22917.4 23599.4 23702.9 23917.3 24350.4 08:31:07 INFO - PID 1644 | 08:31:07 INFO - PID 1644 | [#2] jquery.html Cycles:180 Average:40105.43 Median:23369.86 stddev:112795.87 (482.7%) stddev-sans-first:113072.89 08:31:07 INFO - PID 1644 | Values: 396.8 428.5 431.2 438.2 456.2 20784.5 21616.6 21689.7 22157.2 22528.0 22399.6 22568.7 23197.0 23221.4 23518.3 6229.0 6288.5 6490.7 6491.6 6493.1 6136.5 6346.4 6347.2 6349.8 6353.6 5677.1 5891.8 6283.3 6300.2 6301.9 4477.5 6221.2 6303.8 6314.5 6320.2 4724.7 5572.3 5618.0 5637.4 5645.7 27069.9 27202.7 27536.4 27700.6 27959.6 2038.6 2046.5 2049.5 2050.3 2079.1 16003.0 16506.0 16523.8 16804.9 17222.0 1652.7 1685.1 1689.9 1704.2 1716.4 143472.0 147430.0 158152.0 163465.4 165079.2 10419.8 11940.9 12533.2 12575.0 12804.2 16136.4 16514.2 16531.9 16535.1 16544.5 8797.3 9020.7 9104.4 9115.0 9176.7 7203.5 8622.4 8626.4 8657.7 8761.4 6645.5 7840.8 7845.8 8013.2 8026.6 2120.2 2209.1 2210.8 2215.3 2398.2 927.4 931.7 955.6 956.8 968.1 17648.4 19897.1 20801.8 21026.8 21057.6 953.5 966.6 969.8 982.4 992.7 10277.0 10520.4 10945.3 10971.6 11003.4 638376.0 654452.0 680151.0 685916.0 687659.0 153937.0 154498.0 155384.0 156328.2 159210.0 1119.6 1153.9 1181.7 1182.4 1216.0 20356.8 21123.7 21221.9 21607.5 22081.8 64794.7 65111.0 65464.7 65892.7 65964.3 84357.3 85857.0 86975.7 87379.6 87816.1 8586.0 8610.7 8826.2 8918.1 8945.4 13862.2 13863.6 14024.6 14306.7 14398.0 10433.9 10984.3 11551.6 11840.4 11989.3 9644.5 9869.9 10734.8 11822.3 11949.8 10586.2 11132.8 11672.9 11748.4 12085.0 8758.7 8909.6 8932.7 9073.7 9077.3 10172.0 11439.8 11938.3 11961.9 12168.8 08:31:07 INFO - PID 1644 | 08:31:07 INFO - PID 1644 | [#3] mootools.html Cycles:180 Average:6725.83 Median:2465.45 stddev:4106.12 (166.5%) stddev-sans-first:4096.62 08:31:07 INFO - PID 1644 | Values: 1198.3 1264.7 1313.2 1414.5 1421.4 9518.7 10076.4 10333.9 10688.7 10873.6 10700.2 10845.9 10913.5 10930.0 10947.5 2033.8 2418.8 2465.1 2465.9 2470.1 1984.7 2399.8 2457.7 2461.7 2462.1 2008.3 2393.9 2430.3 2436.2 2441.6 2378.2 2402.9 2405.6 2406.7 2427.6 2354.0 2383.5 2432.3 2445.4 2452.9 10752.4 10859.2 10985.6 11002.8 11023.8 5769.7 5897.1 6172.3 6403.7 6412.5 3954.3 3988.7 4031.2 4059.1 4108.5 1185.9 1510.1 1547.7 1567.9 1633.1 11180.6 13352.7 14981.0 14999.5 15132.2 5459.3 5719.4 5723.1 5742.3 5746.9 12531.9 12610.1 12613.8 12625.9 12627.7 5161.6 6304.6 6310.3 6313.1 6348.2 5714.5 5717.9 5801.7 5802.0 5848.3 4452.9 4469.4 4509.3 4522.3 4532.5 1398.5 1438.6 1455.3 1465.6 1468.3 641.9 772.6 799.0 799.8 831.7 6139.4 6378.2 6731.2 6802.4 6919.6 715.4 892.3 898.8 908.9 920.2 4153.7 4166.4 4227.4 4299.5 4333.7 13401.3 13843.0 13850.9 13852.2 13895.7 13661.2 13661.7 13776.3 13778.2 13808.4 10032.1 10285.2 10331.8 10352.8 10362.8 5438.5 6038.4 6095.3 6192.3 6300.4 11122.8 12430.8 12568.0 12577.1 12586.1 11710.5 11971.9 12126.9 12488.6 12720.9 7693.5 8334.2 8361.7 8459.9 8463.0 9524.4 10039.4 10047.2 10101.8 10136.5 7529.4 8458.6 8798.8 8817.3 9009.8 8518.2 8560.0 8608.2 8654.8 8744.6 7640.7 7662.6 7672.9 7733.2 7734.0 4796.4 5714.2 5802.2 5891.1 5933.8 5598.8 5652.2 5661.9 5827.2 6065.8 08:31:07 INFO - PID 1644 | 08:31:07 INFO - PID 1644 | [#4] prototype.html Cycles:180 Average:5438.27 Median:5987.33 stddev:1673.79 (28.0%) stddev-sans-first:1633.79 08:31:07 INFO - PID 1644 | Values: 319.3 394.4 400.9 401.5 403.7 5852.2 6446.3 6464.9 6465.1 6489.6 5314.3 5962.6 6067.2 6320.5 6345.5 4553.5 4870.5 4883.5 4894.4 4898.7 4227.8 4723.6 4823.5 4927.2 4941.7 4061.8 4662.8 4815.3 4878.0 4899.3 3902.3 4834.7 4835.6 4841.2 4858.6 3491.5 3523.7 4269.7 4312.5 4327.3 5880.5 5907.4 6153.0 6202.5 6206.3 5647.7 5738.7 5754.9 5777.7 5788.5 6447.7 6596.6 6826.0 6950.3 6950.4 3614.1 4807.4 4827.4 4831.5 4834.9 6484.9 6831.1 6863.3 6986.2 7104.6 4285.9 4767.8 4957.5 4972.0 5004.1 4213.5 5054.4 5065.9 5082.3 5097.0 4837.2 5472.0 5640.3 5706.8 5738.0 6822.1 6825.6 6836.6 6905.3 6935.2 1499.6 1523.5 1527.4 1686.4 1742.8 1033.2 1093.4 1109.3 1193.6 1198.1 5422.4 5646.1 6098.9 6408.9 6495.6 5766.8 6450.5 7064.8 7093.0 7096.1 6354.5 6444.4 6454.8 6457.4 6483.7 3145.9 3239.5 3348.1 3439.8 3651.7 6218.3 7106.7 7196.2 7232.5 7247.6 5432.3 5849.1 5876.6 6634.3 7244.0 5995.5 6165.0 6266.0 7193.2 7224.3 6931.9 7005.4 7035.8 7043.8 7088.1 6231.8 6493.5 6624.9 6839.6 6843.8 5312.5 6148.5 6240.3 7079.5 7204.3 3854.6 3916.5 4072.8 4342.2 4950.0 5979.2 6541.2 6799.8 6934.2 6936.9 5872.0 6694.9 6704.0 6727.7 6739.4 6394.4 6507.9 6591.8 6622.9 6731.6 5732.0 6187.4 6538.9 6574.6 6589.2 5532.9 6131.5 6426.0 6589.5 6804.4 6272.9 6503.6 6534.4 6580.6 6661.9 08:31:07 INFO - PID 1644 | 08:31:07 INFO - PID 1644 | [#5] yui.html Cycles:180 Average:18947.61 Median:25195.12 stddev:26661.72 (105.8%) stddev-sans-first:26701.03 08:31:07 INFO - PID 1644 | Values: 628.7 706.3 721.4 722.0 739.3 17291.5 17699.4 18026.8 18279.5 18281.1 16700.5 16717.0 17045.1 17165.4 17224.7 941.7 968.0 970.6 970.8 973.1 932.4 960.4 961.6 972.3 978.9 993.9 1009.6 1010.8 1012.0 1013.8 1010.9 1014.5 1014.7 1016.9 1017.8 747.8 756.6 758.1 758.6 760.2 13282.4 15846.9 16565.8 16784.9 17013.9 13654.9 13969.5 13996.2 14107.7 14156.0 10326.1 10769.8 10942.8 11168.5 11748.6 2702.0 2770.4 2961.3 2989.5 2994.9 105085.0 106559.5 107706.4 120145.6 120492.0 11209.7 11259.3 11429.5 11747.2 11804.1 24582.3 25078.2 25156.5 25158.4 25231.9 7595.4 7621.7 7777.5 8007.7 8019.8 4055.6 4086.4 4121.5 4166.1 4187.9 3394.4 3515.9 4146.6 4203.3 4246.0 788.5 791.9 797.5 798.5 803.9 453.7 496.3 567.5 573.2 575.5 8992.6 9881.7 9942.5 10140.8 10307.8 571.3 573.5 576.8 590.3 597.2 3724.6 4543.6 4674.2 4745.7 4777.2 95398.5 98933.5 100386.0 101177.0 103076.0 57797.7 65256.0 65353.3 70162.3 73383.0 53604.5 57940.0 66686.0 70206.3 70810.6 10531.5 10681.6 10787.7 10862.3 10869.2 35371.8 35599.0 37451.4 37653.0 38638.6 48516.3 48651.0 49473.5 49726.5 50004.0 13400.9 13410.0 13505.5 13947.5 14103.3 14086.6 14455.6 14466.5 14486.3 14666.6 13474.9 13597.9 13600.2 13758.0 14085.2 13307.8 13510.4 13541.3 13950.7 14050.6 12987.7 13006.7 13074.9 13140.8 13551.1 10898.0 11075.9 11093.7 11566.2 11722.2 9625.3 9792.8 10932.4 11172.0 11231.3 08:31:07 INFO - PID 1644 | -------- Summary: end -------- 08:31:07 INFO - PID 1644 | 08:31:07 INFO - TEST-INFO | 1644: exit 0 08:31:07 INFO - TEST-OK | dromaeo_css | took 1117867ms 08:31:07 INFO - TEST-START | kraken 08:31:07 INFO - operating with platform_type : mac_ 08:31:07 INFO - Initialising browser for kraken test... 08:31:07 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/tmp2Yodt7/profile http://localhost:49245/getInfo.html) 08:31:10 INFO - PID 1657 | 2017-03-22 08:31:10.871 plugin-container[1658:10544] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x893f, name = 'com.apple.tsm.portname' 08:31:10 INFO - PID 1657 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:31:10 INFO - PID 1657 | 2017-03-22 08:31:10.874 plugin-container[1658:10544] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4717, name = 'com.apple.CFPasteboardClient' 08:31:10 INFO - PID 1657 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:31:10 INFO - PID 1657 | 2017-03-22 08:31:10.875 plugin-container[1658:10544] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:31:10 INFO - PID 1657 | __metrics Screen width/height:1600/1200 08:31:10 INFO - PID 1657 | colorDepth:24 08:31:10 INFO - PID 1657 | Browser inner width/height: 1024/689 08:31:10 INFO - PID 1657 | __metrics 08:31:11 ERROR - PID 1657 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3350: TypeError: this.tabs is undefined 08:31:11 INFO - TEST-INFO | 1657: exit 0 08:31:11 INFO - Browser initialized. 08:31:11 INFO - Running cycle 1/1 for kraken test... 08:31:11 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/tmp2Yodt7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:31:14 INFO - PID 1659 | 2017-03-22 08:31:14.428 plugin-container[1660:10665] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b4b, name = 'com.apple.tsm.portname' 08:31:14 INFO - PID 1659 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:31:14 INFO - PID 1659 | 2017-03-22 08:31:14.429 plugin-container[1660:10665] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b4f, name = 'com.apple.CFPasteboardClient' 08:31:14 INFO - PID 1659 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:31:14 INFO - PID 1659 | 2017-03-22 08:31:14.429 plugin-container[1660:10665] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:31:24 INFO - PID 1659 | RSS: Main: 227516416 08:31:24 INFO - PID 1659 | 08:31:26 INFO - PID 1659 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49245/tests/kraken/driver.html?testName=audio-beat-detection) 08:31:27 INFO - PID 1659 | RSS: Main: 242315264 08:31:27 INFO - PID 1659 | 08:31:30 INFO - PID 1659 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49245/tests/kraken/driver.html?testName=audio-dft) 08:31:31 INFO - PID 1659 | RSS: Main: 250789888 08:31:31 INFO - PID 1659 | 08:31:34 INFO - PID 1659 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49245/tests/kraken/driver.html?testName=audio-fft) 08:31:35 INFO - PID 1659 | RSS: Main: 253288448 08:31:35 INFO - PID 1659 | 08:31:37 INFO - PID 1659 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49245/tests/kraken/driver.html?testName=audio-oscillator) 08:31:37 INFO - PID 1659 | RSS: Main: 255619072 08:31:37 INFO - PID 1659 | 08:31:39 INFO - PID 1659 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49245/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:31:40 INFO - PID 1659 | RSS: Main: 256286720 08:31:40 INFO - PID 1659 | 08:31:43 INFO - PID 1659 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49245/tests/kraken/driver.html?testName=imaging-darkroom) 08:31:44 INFO - PID 1659 | RSS: Main: 261804032 08:31:44 INFO - PID 1659 | 08:31:47 INFO - PID 1659 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49245/tests/kraken/driver.html?testName=imaging-desaturate) 08:31:48 INFO - PID 1659 | RSS: Main: 262651904 08:31:48 INFO - PID 1659 | 08:31:51 INFO - PID 1659 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49245/tests/kraken/driver.html?testName=json-parse-financial) 08:31:51 INFO - PID 1659 | RSS: Main: 262627328 08:31:51 INFO - PID 1659 | 08:31:53 INFO - PID 1659 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49245/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:31:54 INFO - PID 1659 | RSS: Main: 262410240 08:31:54 INFO - PID 1659 | 08:31:55 INFO - PID 1659 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:31:56 INFO - PID 1659 | RSS: Main: 262721536 08:31:56 INFO - PID 1659 | 08:31:58 INFO - PID 1659 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:31:59 INFO - PID 1659 | RSS: Main: 262561792 08:31:59 INFO - PID 1659 | 08:32:02 INFO - PID 1659 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:32:03 INFO - PID 1659 | RSS: Main: 263245824 08:32:03 INFO - PID 1659 | 08:32:06 INFO - PID 1659 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:32:07 INFO - PID 1659 | RSS: Main: 262709248 08:32:07 INFO - PID 1659 | 08:32:08 INFO - PID 1659 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49245/tests/kraken/driver.html?testName=ai-astar) 08:32:09 INFO - PID 1659 | RSS: Main: 264396800 08:32:09 INFO - PID 1659 | 08:32:09 INFO - PID 1659 | __start_tp_report 08:32:09 INFO - PID 1659 | _x_x_mozilla_page_load 08:32:09 INFO - PID 1659 | _x_x_mozilla_page_load_details 08:32:09 INFO - PID 1659 | |i|pagename|runs| 08:32:09 INFO - PID 1659 | |0;ai-astar;100;114;113;112;124;115;113;112;114;115 08:32:09 INFO - PID 1659 | |1;audio-beat-detection;150;117;114;154;116;117;112;116;149;153 08:32:09 INFO - PID 1659 | |2;audio-dft;199;205;208;215;208;260;279;200;229;275 08:32:09 INFO - PID 1659 | |3;audio-fft;81;61;60;86;60;62;61;57;71;60 08:32:09 INFO - PID 1659 | |4;audio-oscillator;91;69;84;70;71;74;115;107;84;83 08:32:09 INFO - PID 1659 | |5;imaging-gaussian-blur;89;88;89;87;129;119;134;134;92;98 08:32:09 INFO - PID 1659 | |6;imaging-darkroom;93;92;159;157;96;98;97;97;127;102 08:32:09 INFO - PID 1659 | |7;imaging-desaturate;90;93;91;92;90;91;94;90;92;90 08:32:09 INFO - PID 1659 | |8;json-parse-financial;67;70;80;101;105;108;74;68;68;66 08:32:09 INFO - PID 1659 | |9;json-stringify-tinderbox;57;53;67;68;65;61;58;59;59;57 08:32:09 INFO - PID 1659 | |10;stanford-crypto-aes;86;77;103;109;111;107;86;83;87;86 08:32:09 INFO - PID 1659 | |11;stanford-crypto-ccm;143;173;141;137;131;152;151;153;191;166 08:32:09 INFO - PID 1659 | |12;stanford-crypto-pbkdf2;190;192;184;189;189;191;190;197;166;185 08:32:09 INFO - PID 1659 | |13;stanford-crypto-sha256-iterative;70;69;67;70;69;66;71;67;69;69 08:32:09 INFO - PID 1659 | __end_tp_report 08:32:09 INFO - PID 1659 | __start_cc_report 08:32:09 INFO - PID 1659 | _x_x_mozilla_cycle_collect,994 08:32:09 INFO - PID 1659 | __end_cc_report 08:32:09 INFO - PID 1659 | __startTimestamp1490196729022__endTimestamp 08:32:09 INFO - PID 1659 | 08:32:09 INFO - PID 1659 | ------- Summary: start ------- 08:32:09 INFO - PID 1659 | Number of tests: 14 08:32:09 INFO - PID 1659 | 08:32:09 INFO - PID 1659 | [#0] ai-astar Cycles:10 Average:113.20 Median:114.00 stddev:5.79 (5.1%) stddev-sans-first:3.67 08:32:09 INFO - PID 1659 | Values: 100.0 114.0 113.0 112.0 124.0 115.0 113.0 112.0 114.0 115.0 08:32:09 INFO - PID 1659 | 08:32:09 INFO - PID 1659 | [#1] audio-beat-detection Cycles:10 Average:129.80 Median:133.00 stddev:18.78 (14.1%) stddev-sans-first:18.45 08:32:09 INFO - PID 1659 | Values: 150.0 117.0 114.0 154.0 116.0 117.0 112.0 116.0 149.0 153.0 08:32:09 INFO - PID 1659 | 08:32:09 INFO - PID 1659 | [#2] audio-dft Cycles:10 Average:227.80 Median:222.00 stddev:31.55 (14.2%) stddev-sans-first:31.69 08:32:09 INFO - PID 1659 | Values: 199.0 205.0 208.0 215.0 208.0 260.0 279.0 200.0 229.0 275.0 08:32:09 INFO - PID 1659 | 08:32:09 INFO - PID 1659 | [#3] audio-fft Cycles:10 Average:65.90 Median:61.50 stddev:10.03 (16.3%) stddev-sans-first:9.02 08:32:09 INFO - PID 1659 | Values: 81.0 61.0 60.0 86.0 60.0 62.0 61.0 57.0 71.0 60.0 08:32:09 INFO - PID 1659 | 08:32:09 INFO - PID 1659 | [#4] audio-oscillator Cycles:10 Average:84.80 Median:78.50 stddev:15.72 (20.0%) stddev-sans-first:16.51 08:32:09 INFO - PID 1659 | Values: 91.0 69.0 84.0 70.0 71.0 74.0 115.0 107.0 84.0 83.0 08:32:09 INFO - PID 1659 | 08:32:09 INFO - PID 1659 | [#5] imaging-gaussian-blur Cycles:10 Average:105.90 Median:88.50 stddev:20.52 (23.2%) stddev-sans-first:20.83 08:32:09 INFO - PID 1659 | Values: 89.0 88.0 89.0 87.0 129.0 119.0 134.0 134.0 92.0 98.0 08:32:09 INFO - PID 1659 | 08:32:09 INFO - PID 1659 | [#6] imaging-darkroom Cycles:10 Average:111.80 Median:94.50 stddev:26.29 (27.8%) stddev-sans-first:26.99 08:32:09 INFO - PID 1659 | Values: 93.0 92.0 159.0 157.0 96.0 98.0 97.0 97.0 127.0 102.0 08:32:09 INFO - PID 1659 | 08:32:09 INFO - PID 1659 | [#7] imaging-desaturate Cycles:10 Average:91.30 Median:91.50 stddev:1.42 (1.5%) stddev-sans-first:1.42 08:32:09 INFO - PID 1659 | Values: 90.0 93.0 91.0 92.0 90.0 91.0 94.0 90.0 92.0 90.0 08:32:09 INFO - PID 1659 | 08:32:09 INFO - PID 1659 | [#8] json-parse-financial Cycles:10 Average:80.70 Median:68.00 stddev:17.11 (25.2%) stddev-sans-first:17.41 08:32:09 INFO - PID 1659 | Values: 67.0 70.0 80.0 101.0 105.0 108.0 74.0 68.0 68.0 66.0 08:32:09 INFO - PID 1659 | 08:32:09 INFO - PID 1659 | [#9] json-stringify-tinderbox Cycles:10 Average:60.40 Median:60.00 stddev:4.84 (8.1%) stddev-sans-first:4.97 08:32:09 INFO - PID 1659 | Values: 57.0 53.0 67.0 68.0 65.0 61.0 58.0 59.0 59.0 57.0 08:32:09 INFO - PID 1659 | 08:32:09 INFO - PID 1659 | [#10] stanford-crypto-aes Cycles:10 Average:93.50 Median:84.50 stddev:12.53 (14.8%) stddev-sans-first:12.99 08:32:09 INFO - PID 1659 | Values: 86.0 77.0 103.0 109.0 111.0 107.0 86.0 83.0 87.0 86.0 08:32:09 INFO - PID 1659 | 08:32:09 INFO - PID 1659 | [#11] stanford-crypto-ccm Cycles:10 Average:153.80 Median:152.50 stddev:18.24 (12.0%) stddev-sans-first:18.93 08:32:09 INFO - PID 1659 | Values: 143.0 173.0 141.0 137.0 131.0 152.0 151.0 153.0 191.0 166.0 08:32:09 INFO - PID 1659 | 08:32:09 INFO - PID 1659 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:187.30 Median:190.00 stddev:8.30 (4.4%) stddev-sans-first:8.75 08:32:09 INFO - PID 1659 | Values: 190.0 192.0 184.0 189.0 189.0 191.0 190.0 197.0 166.0 185.0 08:32:09 INFO - PID 1659 | 08:32:09 INFO - PID 1659 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:69.00 stddev:1.57 (2.3%) stddev-sans-first:1.59 08:32:09 INFO - PID 1659 | Values: 70.0 69.0 67.0 70.0 69.0 66.0 71.0 67.0 69.0 69.0 08:32:09 INFO - PID 1659 | -------- Summary: end -------- 08:32:09 INFO - PID 1659 | 08:32:10 INFO - TEST-INFO | 1659: exit 0 08:32:10 INFO - TEST-OK | kraken | took 62179ms 08:32:10 INFO - SUITE-END | took 1180s 08:32:10 INFO - Completed test suite (00:19:40) 08:32:10 INFO - javascript benchmark 08:32:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7706.829186099966, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3545.645435456453, 3555.9466608000885, 3604.5674519057716, 3624.2751449710063, 3635.3456377851994, 4928.950710492894, 6118.969405152968, 6139.1712118864, 6140.631562106266, 6165.414285642868, 4848.272759086139, 6120.904292401153, 6171.845703857406, 6175.1663525424165, 6188.969055154729, 5427.945720542803, 5546.168074788774, 5584.832455026356, 5621.943780562204, 5668.886622267552, 3981.9402708959387, 4675.602573781216, 5075.238714192882, 5679.943200567983, 5710.77156913723, 5464.0, 5625.71871406428, 5635.1828984797385, 5666.773329066853, 5678.886422271552, 5504.256925315071, 5511.448855114497, 5532.806351777709, 5535.806246781343, 5537.556995440355, 5504.256925315071, 5541.9168712469345, 5551.333839939233, 5574.080276754331, 5628.43715628438, 4756.9286460703115, 6080.118382834465, 6165.352637972993, 6175.042868355412, 6184.81445556634, 6295.905561416583, 6639.634820084893, 6675.566088204251, 6676.632785196813, 6683.2982536833415, 6566.67166641666, 6652.767153149665, 6701.128853249046, 6743.696533655997, 6764.425023872976, 5180.844574662766, 6236.532260080512, 6280.842978925518, 6298.4331410172845, 6309.684515774285, 5888.558358123158, 6500.089987401768, 6819.931800681929, 6850.38346548813, 6911.89632155518, 6364.045393191059, 6399.584027038228, 6420.357964203636, 6532.967335163294, 6562.376574225441, 6685.799426017227, 6701.832454188587, 6711.899321510181, 6733.46132309414, 6740.595564266159, 6539.8555252830565, 6561.3438656134, 6601.504887133484, 6617.172853393326, 6631.900521492182, 6403.199600049994, 6481.384268494579, 6573.769918052845, 6607.438367738796, 6666.466682665375, 5308.814191503279, 5326.9467305327225, 5333.200019997032, 5337.759800808895, 5356.625036247503, 4722.905541889143, 4756.286557016406, 4769.35613692154, 4772.069446457907, 4810.230363141881, 6181.629102253879, 6244.968775156095, 6303.558750887486, 6338.683065846689, 6355.745770169141, 6767.0, 6784.491163162783, 6793.082933803972, 6797.728090876409, 6817.761378351734, 6246.614015119506, 6357.300696923335, 6382.5851319665, 6393.904091438632, 6400.167978162902, 4908.828191013297, 5771.942280577225, 5796.507296879812, 5827.94172058274, 5949.2266005419015, 6795.1845778506895, 6876.587404755731, 6881.862362752817, 6898.724051037902, 6911.930880691129, 6439.06633538125, 6732.394084532416, 6754.696038678173, 6754.966225168842, 6791.0, 6612.966935165294, 6698.0, 6807.693653785691, 6875.346842049998, 6883.724651013903, 6447.967760161169, 6655.933440665532, 6671.332866713484, 6671.733130674718, 6699.09562209115, 6551.639659818756, 6615.17310336208, 6637.037629543593, 6699.43054840344, 6741.932580674326, 6524.869502610016, 6527.281998980014, 6540.37866402691, 6552.24649165333, 6575.80272591823, 6462.612243265231, 6485.897397442352, 6503.544751867324, 6551.050097735706, 6553.4101930826455, 6117.449429551361, 6145.125736650186, 6271.466925311217, 6274.686265686789, 6402.35976402356, 5692.601517893708, 6514.055461957895, 6550.082988381535, 6568.244651865097, 6580.605163690194, 5319.122344813217, 6236.18929539157, 6395.488360931021, 6421.133147025092, 6442.677866106769], "value": 6057.553016717153, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [754.2156157596097, 776.6776787633131, 829.4691397505595, 1291.502771432998, 1293.644247831846, 28766.712332876665, 37843.81078094613, 37854.8107259464, 37922.24155516891, 37943.343965922395, 36917.446238306446, 37354.0, 37444.442777936056, 37452.25095498088, 37484.62515374846, 7900.288973992339, 8060.274575288223, 8432.40973131881, 8653.69712060078, 8654.350923680719, 8601.827963440728, 8661.263792577638, 8719.60761765719, 8727.301815854747, 8732.607032683512, 8659.09079546648, 8676.566171691422, 8725.083866194022, 8744.825103497926, 8760.956195219014, 8703.869441958375, 8720.563971801384, 8732.257758090507, 8750.781230469225, 8761.036286008533, 7326.597037162954, 7916.129225785159, 8070.668339723998, 8567.0, 8626.784330391727, 37168.0, 37345.439818402745, 37380.81309593435, 37503.62496375056, 37534.0, 2981.95527067092, 3016.8491575421363, 3032.348045170299, 3035.165329534396, 3045.512717965137, 23443.94502247403, 26557.867210664015, 27495.587566186525, 27860.303492412648, 28076.017339393024, 2764.4747497975322, 2765.769232691453, 2772.126780064273, 2774.4173723518084, 2793.106206014076, 227951.0, 232624.0, 236526.0, 331171.0, 331433.0, 35942.460863086555, 44805.0, 44947.426840061096, 45136.77431612887, 45235.773821130686, 42761.0, 46611.30083048757, 47075.293870591966, 47281.5271847284, 47323.76338118287, 12322.876771232352, 13874.167549946833, 14262.786058209134, 14290.785638215228, 14318.0, 11494.655160345203, 11694.47374868133, 11736.354500502384, 11764.88235117655, 11767.646970590724, 13581.592552223448, 13594.0, 13616.86383136156, 13618.727625447635, 13772.311384430739, 5095.592352611782, 5971.343152253248, 6031.698415079229, 6039.78860739872, 6048.637081775019, 960.9951950240204, 973.7730459620788, 976.7411635916487, 979.6816034788723, 1020.4489575629077, 20116.39650810478, 23852.0, 23870.045198192227, 23954.845116954664, 24166.516669666507, 1045.4041196517912, 1057.3127467146262, 1101.2566517600587, 1101.7961677089763, 1113.507899414788, 11219.775604487864, 11368.658940231806, 11848.644540663794, 12339.444724987397, 12415.75168496625, 393181.0, 448581.0, 457808.0, 462448.0, 462656.0, 51326.74336628293, 51871.74064129731, 52127.739361303706, 52364.0, 52427.0, 1345.79140233264, 1487.4273404739254, 1489.8137732783184, 1497.3262032085604, 1500.9774853377207, 16970.40603578869, 22084.88957555202, 22337.32988010362, 22905.350860582304, 22974.77025229726, 36609.0, 36720.81639591785, 36841.07897302589, 36897.63102368942, 36959.0, 452900.73549633357, 453194.0, 453384.0, 455467.0, 456734.0, 25796.0, 31458.89893853704, 32645.673543264264, 33455.83272083624, 33652.66347336593, 34651.0, 42247.78876105723, 42772.358414624425, 42791.0, 43757.0, 30407.54388684127, 31059.602317895296, 34960.30079398449, 35024.64975350214, 35894.64105358913, 31756.6824331763, 34445.82777086098, 35251.64748352586, 35671.64328356787, 36080.639193608775, 35030.824845875606, 35447.0, 35801.64198357983, 35865.28269434649, 35916.82041589775, 26415.0, 31504.527432088078, 31741.889033883705, 31793.523097154022, 31827.0, 22917.427064323525, 23599.41001474977, 23702.881485593152, 23917.28248152558, 24350.39124021843], "value": 17425.556831241578, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [396.76590811421266, 428.5050766364846, 431.2345586583815, 438.1915366149454, 456.1720477333639, 20784.48038799031, 21616.567668646636, 21689.7225791292, 22157.224497142604, 22528.0, 22399.55200895981, 22568.66147007796, 23197.0, 23221.419464513394, 23518.294451166494, 6228.972219583786, 6288.496920246369, 6490.707918143671, 6491.642959637218, 6493.123428337185, 6136.509079273647, 6346.365363463663, 6347.206599175103, 6349.809505714836, 6353.555251132422, 5677.148427735852, 5891.764329426818, 6283.3088360280335, 6300.180976473052, 6301.936980630181, 4477.485089214733, 6221.222347206599, 6303.779367722108, 6314.463270622003, 6320.241571011485, 4724.6928949618505, 5572.3034620672415, 5618.0, 5637.3517045539875, 5645.661260324394, 27069.917203311845, 27202.72797272022, 27536.44927101467, 27700.584491232647, 27959.58060629092, 2038.5820906714089, 2046.467918341227, 2049.5286084200716, 2050.29264903608, 2079.105984426696, 16003.0, 16506.0, 16523.83476165235, 16804.915975420045, 17221.951243790936, 1652.6612044530843, 1685.1489997551157, 1689.8817082804208, 1704.2416124824458, 1716.364944970369, 143472.0, 147430.0, 158152.0, 163465.3653463462, 165079.17460412742, 10419.791604167875, 11940.88059119415, 12533.185342952678, 12575.0, 12804.231746095264, 16136.435224767078, 16514.174291285388, 16531.91734041322, 16535.106356387583, 16544.50366489007, 8797.340199485065, 9020.691999660145, 9104.408213466104, 9114.954425227832, 9176.724698259062, 7203.459740519482, 8622.353323500636, 8626.353023523261, 8657.696980605648, 8761.430507017023, 6645.534812563171, 7840.84318313642, 7845.843083138306, 8013.238742319587, 8026.558539280396, 2120.2155202575145, 2209.149477451193, 2210.767869373725, 2215.268961242786, 2398.2085911649115, 927.420362273579, 931.7065124485765, 955.6320816485564, 956.8038552096804, 968.138356862393, 17648.382306619464, 19897.104630291673, 20801.79198208029, 21026.78973210279, 21057.57884842325, 953.4755884263766, 966.5988614724811, 969.7721035556639, 982.3958265666706, 992.7071513903416, 10277.0, 10520.368777873353, 10945.288556243819, 10971.615993440191, 11003.449827508593, 638376.0, 654452.0, 680151.0, 685916.0, 687659.0, 153937.0, 154498.0, 155384.0, 156328.21835890747, 159210.0, 1119.630521927762, 1153.9365334906493, 1181.6927598824195, 1182.43243243242, 1216.0332535634016, 20356.79643203549, 21123.683144753148, 21221.89389053045, 21607.45981350479, 22081.779182208615, 64794.67602661956, 65111.0, 65464.67267663631, 65892.67053664701, 65964.34035659581, 84357.3128537438, 85857.0, 86975.65121743761, 87379.56310218408, 87816.0965513107, 8586.0, 8610.698625548326, 8826.161514656098, 8918.10818918103, 8945.37382383253, 13862.168269903837, 13863.584092477242, 14024.649383765487, 14306.713865722835, 14398.0, 10433.895661043292, 10984.340939543654, 11551.595694150665, 11840.407979600814, 11989.34058626784, 9644.517774111408, 9869.901300986898, 10734.785304294026, 11822.290662560274, 11949.820752688544, 10586.206034547593, 11132.833007505056, 11672.941635291769, 11748.412579371168, 12085.0, 8758.693445729368, 8909.643614255358, 8932.732018039469, 9073.727788166365, 9077.273818094669, 10172.033656802592, 11439.771204576029, 11938.28370297785, 11961.880381196424, 12168.756624867276], "value": 10495.486663559124, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1198.3169593331802, 1264.7407281507292, 1313.1989486413293, 1414.5402744108167, 1421.438531779947, 9518.714973478587, 10076.445795481264, 10333.948330258347, 10688.679339619814, 10873.619423320186, 10700.197485188603, 10845.945770271157, 10913.454327283644, 10930.0, 10947.507362168702, 2033.7661168965537, 2418.794402475787, 2465.050955382173, 2465.852048877064, 2470.086068154785, 1984.7419835421374, 2399.7960173385195, 2457.680501534798, 2461.716902556202, 2462.076721229539, 2008.317172161465, 2393.9281821545296, 2430.331658793837, 2436.2325867351815, 2441.5727247731666, 2378.2270762002245, 2402.870650794124, 2405.615101583756, 2406.723226828911, 2427.647991041298, 2353.9646905296436, 2383.5232953409213, 2432.3067925641285, 2445.3642053066333, 2452.9141480048293, 10752.408617526033, 10859.239853210278, 10985.61550345734, 11002.834957475645, 11023.779524409547, 5769.730659254958, 5897.0859516774535, 6172.259328880518, 6403.711832967528, 6412.487001039905, 3954.3277642800504, 3988.700847436454, 4031.21391328691, 4059.147579008412, 4108.548059713429, 1185.9407029648482, 1510.1090356689606, 1547.667251540913, 1567.9451219207274, 1633.1426001349269, 11180.608678696288, 13352.732945341137, 14981.02623329491, 14999.475018374305, 15132.167730774803, 5459.2902922619805, 5719.428057194331, 5723.084306510938, 5742.3396309424115, 5746.913796293059, 12531.93734031324, 12610.054245931591, 12613.810792838114, 12625.936870315589, 12627.684307892192, 5161.638685292069, 6304.590201636879, 6310.337414571496, 6313.147725057151, 6348.238211414659, 5714.457126572969, 5717.885642287131, 5801.7099145042575, 5801.970990145022, 5848.3274423441, 4452.9109417812115, 4469.41897553316, 4509.346144808985, 4522.29904364824, 4532.546745325507, 1398.4685819388567, 1438.6331485471137, 1455.3087283540233, 1465.6482444213311, 1468.2511918921214, 641.900505421651, 772.5750837039606, 798.9920100799034, 799.7960520067462, 831.7005877883956, 6139.3730661373875, 6378.202724659418, 6731.158605174353, 6802.387785099365, 6919.550229235184, 715.4026387966106, 892.3218354050967, 898.8247291778172, 908.9454632722058, 920.1580553793204, 4153.709240353146, 4166.354215096665, 4227.408162857202, 4299.548547402478, 4333.653307735373, 13401.329933503286, 13843.0, 13850.930745346208, 13852.238126902916, 13895.722085558435, 13661.248631325372, 13661.658458538615, 13776.311184440938, 13778.242196679279, 13808.378622961991, 10032.1472674822, 10285.22860785444, 10331.845022324671, 10352.844707329396, 10362.792744145225, 5438.537724293479, 6038.426349496791, 6095.2685677718955, 6192.349803270772, 6300.369963003663, 11122.833157502482, 12430.751384972069, 12568.0, 12577.119601627799, 12586.118971671895, 11710.473028713557, 11971.880281197426, 12126.878731212928, 12488.625341239778, 12720.87279127197, 7693.538387696756, 8334.249917507454, 8361.749147525585, 8459.91540084616, 8462.957685211535, 9524.380915240487, 10039.4478303694, 10047.196224301892, 10101.79796404053, 10136.493175341056, 7529.397648188023, 8458.562044452336, 8798.780030499032, 8817.294616430541, 9009.81980360376, 8518.190771876662, 8560.0, 8608.225259726654, 8654.82690346202, 8744.606492707717, 7640.656170472231, 7662.578558179353, 7672.923270767221, 7733.221359087329, 7733.994580704472, 4796.35249241348, 5714.171445140514, 5802.216700745345, 5891.1457838614015, 5933.842900634335, 5598.776048958159, 5652.152177173457, 5661.943380566142, 5827.155062515827, 6065.7573697053385], "value": 5176.075246817089, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [319.3086966717058, 394.35129212445526, 400.9355162044772, 401.51416785689315, 403.73555321264564, 5852.190948344797, 6446.258680251773, 6464.9009668356375, 6465.127207826942, 6489.643069631168, 5314.3091398118195, 5962.582619216657, 6067.178761875727, 6320.462760665349, 6345.49236061114, 4553.521880202581, 4870.464248932623, 4883.536064073925, 4894.4371397289415, 4898.681585696936, 4227.8308867645255, 4723.5512626300615, 4823.469418363977, 4927.162382395001, 4941.654084214107, 4061.776602286873, 4662.766861656921, 4815.253635686474, 4878.0, 4899.289603007562, 3902.278078555448, 4834.709917404932, 4835.588974937117, 4841.152798260308, 4858.611311095104, 3491.476278558211, 3523.700485458739, 4269.658427325838, 4312.525622181557, 4327.307630779092, 5880.470757631791, 5907.438793314671, 6153.0, 6202.503799696058, 6206.2862770781485, 5647.745851436695, 5738.684372359518, 5754.913676294859, 5777.711114444261, 5788.5369170466265, 6447.677616119222, 6596.60420374779, 6825.976103584452, 6950.339717726808, 6950.409215216712, 3614.0845351963503, 4807.399075115611, 4827.444843842933, 4831.541003604652, 4834.854954351375, 6484.865148598977, 6831.096783866837, 6863.2793556676825, 6986.161660600709, 7104.6447677615915, 4285.935710964338, 4767.785449654774, 4957.4794646561595, 4971.975140124277, 5004.149294619923, 4213.452251207324, 5054.418741844662, 5065.898682026413, 5082.25558198576, 5096.974515127475, 4837.2260438329695, 5472.002719007533, 5640.323161220597, 5706.771729130871, 5738.0, 6822.147231596051, 6825.624590647562, 6836.555623884432, 6905.309469053054, 6935.202451718016, 1499.6475828180369, 1523.4820161145265, 1527.4043123181968, 1686.4434736536914, 1742.7647267618709, 1033.2095946600857, 1093.4040947683532, 1109.3177695717077, 1193.5941779794912, 1198.1253684810138, 5422.43064478232, 5646.068398714248, 6098.878022439526, 6408.903866442007, 6495.610263384212, 5766.799426318434, 6450.516381232249, 7064.752733654297, 7093.0, 7096.077509923677, 6354.474926017722, 6444.387783160592, 6454.806355809334, 6457.354264573505, 6483.7082331295205, 3145.9303836695176, 3239.5140728890856, 3348.0783248624484, 3439.7764145330975, 3651.707863370924, 6218.347073557302, 7106.680199391039, 7196.172440169447, 7232.493725439274, 7247.5720633588335, 5432.266644003009, 5849.064149736022, 5876.559258055663, 6634.303398143222, 7244.0, 5995.481897603017, 6165.0, 6266.0, 7193.208747037717, 7224.277572242734, 6931.93068069333, 7005.404540613901, 7035.753748618774, 7043.788686339418, 7088.109204648776, 6231.781887633911, 6493.545451818327, 6624.933750662624, 6839.555428897106, 6843.828904277433, 5312.5484333832055, 6148.50811935053, 6240.251169859646, 7079.469039822137, 7204.308596208936, 3854.5759966404235, 3916.4908561886773, 4072.7759973200573, 4342.240107981153, 4950.0, 5979.182037528277, 6541.233866856018, 6799.796006119825, 6934.237233904166, 6936.930630693831, 5872.032868988937, 6694.933050669626, 6703.966480167568, 6727.697253623696, 6739.427148692416, 6394.360563943568, 6507.869842603027, 6591.835204119935, 6622.933770662425, 6731.596104233761, 5732.0, 6187.388628502141, 6538.907549584087, 6574.638394888327, 6589.24223714279, 5532.944670553243, 6131.54013449002, 6426.0, 6589.47284217271, 6804.353586409283, 6272.874542509216, 6503.577267477788, 6534.379233972765, 6580.638064906476, 6661.900071498834], "value": 4915.038583958161, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [628.7139351595025, 706.3148745716657, 721.4228617106313, 721.9927800721991, 739.3309055304948, 17291.481255562336, 17699.380521681745, 18026.81973180268, 18279.45161645151, 18281.08594570271, 16700.498985030437, 16716.996980181197, 17045.14774261285, 17165.399211027587, 17224.741628875578, 941.7410212191668, 967.9903200967971, 970.587500312368, 970.8349580571285, 973.1339108193678, 932.4265576670333, 960.4093482508242, 961.6105477281677, 972.2659392158945, 978.931474796761, 993.9403635781877, 1009.5860697114184, 1010.8433192855119, 1011.9797604047915, 1013.7871047080122, 1010.9292349535499, 1014.5130337437997, 1014.6854475112701, 1016.8678071850612, 1017.8218811707995, 747.7906186267853, 756.6405957170355, 758.0902916500222, 758.5979430901631, 760.2169765141857, 13282.402291896888, 15846.890717649769, 16565.83434165655, 16784.916075419667, 17013.89409688366, 13654.931725341408, 13969.511067112602, 13996.230207338593, 14107.65607536322, 14156.009079364449, 10326.070653641133, 10769.784604307948, 10942.781144377148, 11168.497417616227, 11748.588799392066, 2701.9729802702113, 2770.4182121754457, 2961.318896653782, 2989.4618968585646, 2994.895178668736, 105085.0, 106559.4672026635, 107706.384404234, 120145.62504035486, 120492.0, 11209.71975700614, 11259.324440533594, 11429.485673144729, 11747.17769756126, 11804.055675546108, 24582.262532123706, 25078.24765257045, 25156.496870062496, 25158.371040724127, 25231.873840631048, 7595.392368610498, 7621.69513219465, 7777.455578109591, 8007.678733008988, 8019.83960320802, 4055.614716601918, 4086.3870419436726, 4121.4848143982, 4166.145940082337, 4187.895302617459, 3394.405978953673, 3515.9472607910902, 4146.626803587692, 4203.285441474956, 4246.0, 788.4993029426241, 791.8574656561874, 797.493591569346, 798.4849771897094, 803.9075506316732, 453.71869440946824, 496.27543786072016, 567.5402923631872, 573.2089716191629, 575.545319197829, 8992.640294388282, 9881.654142104991, 9942.502874856229, 10140.797184056277, 10307.84538231927, 571.2773341722724, 573.5211098732522, 576.7923547522888, 590.3181824992141, 597.2206270816539, 3724.625242020814, 4543.568361005699, 4674.182018146811, 4745.691530050535, 4777.187878060738, 95398.52300738591, 98933.50533247432, 100386.0, 101177.0, 103076.0, 57797.71101144468, 65256.0, 65353.34646653473, 70162.2983770166, 73383.0, 53604.46395536073, 57940.0, 66686.0, 70206.29793701998, 70810.64594676993, 10531.526081326205, 10681.570719330553, 10787.67636970892, 10862.34825910448, 10869.239153259196, 35371.82314088413, 35599.0, 37451.43822842605, 37653.0, 38638.613613864625, 48516.272255915486, 48651.0, 49473.50526494833, 49726.502734973634, 50004.0, 13400.865991339962, 13410.0, 13505.459781608626, 13947.51183708606, 14103.2948352584, 14086.647833804236, 14455.566333010027, 14466.493672721404, 14486.348114334669, 14666.56000319992, 13474.865251347754, 13597.86402135966, 13600.183988960694, 13758.036937414285, 14085.15489070659, 13307.80038299407, 13510.392032358372, 13541.255230961997, 13950.707698745875, 14050.578482645536, 12987.675308116995, 13006.674833129247, 13074.869251307366, 13140.831762759037, 13551.119177253448, 10898.0, 11075.944620276847, 11093.722656933642, 11566.190366674253, 11722.179447438597, 9625.32622716403, 9792.804143917225, 10932.398718070583, 11172.0, 11231.326120432801], "value": 7433.782565614298, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1574.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 114.0, 113.0, 112.0, 124.0, 115.0, 113.0, 112.0, 114.0, 115.0], "value": 113.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 117.0, 114.0, 154.0, 116.0, 117.0, 112.0, 116.0, 149.0, 153.0], "value": 129.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [199.0, 205.0, 208.0, 215.0, 208.0, 260.0, 279.0, 200.0, 229.0, 275.0], "value": 227.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 61.0, 60.0, 86.0, 60.0, 62.0, 61.0, 57.0, 71.0, 60.0], "value": 65.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 69.0, 84.0, 70.0, 71.0, 74.0, 115.0, 107.0, 84.0, 83.0], "value": 84.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 88.0, 89.0, 87.0, 129.0, 119.0, 134.0, 134.0, 92.0, 98.0], "value": 105.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 159.0, 157.0, 96.0, 98.0, 97.0, 97.0, 127.0, 102.0], "value": 111.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 93.0, 91.0, 92.0, 90.0, 91.0, 94.0, 90.0, 92.0, 90.0], "value": 91.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 70.0, 80.0, 101.0, 105.0, 108.0, 74.0, 68.0, 68.0, 66.0], "value": 80.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 53.0, 67.0, 68.0, 65.0, 61.0, 58.0, 59.0, 59.0, 57.0], "value": 60.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 77.0, 103.0, 109.0, 111.0, 107.0, 86.0, 83.0, 87.0, 86.0], "value": 93.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 173.0, 141.0, 137.0, 131.0, 152.0, 151.0, 153.0, 191.0, 166.0], "value": 153.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [190.0, 192.0, 184.0, 189.0, 189.0, 191.0, 190.0, 197.0, 166.0, 185.0], "value": 187.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 69.0, 67.0, 70.0, 69.0, 66.0, 71.0, 67.0, 69.0, 69.0], "value": 68.7, "unit": "score"}]}]} 08:32:10 INFO - Return code: 0 08:32:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:32:10 ERROR - # TBPL SUCCESS # 08:32:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:32:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:32:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:32:10 INFO - 2017-03-22 08:32:10.355 screenresolution[1664:11053] starting screenresolution argv=screenresolution get 08:32:10 INFO - 2017-03-22 08:32:10.358 screenresolution[1664:11053] Display 0: 1600x1200x32@60 08:32:10 INFO - 2017-03-22 08:32:10.364 screenresolution[1665:11056] starting screenresolution argv=screenresolution list 08:32:10 INFO - Available Modes on Display 0 08:32:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:32:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:32:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:32:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:32:10 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:32:10 INFO - Intel Iris: 08:32:10 INFO - Chipset Model: Intel Iris 08:32:10 INFO - Type: GPU 08:32:10 INFO - Bus: Built-In 08:32:10 INFO - VRAM (Dynamic, Max): 1536 MB 08:32:10 INFO - Vendor: Intel (0x8086) 08:32:10 INFO - Device ID: 0x0a2e 08:32:10 INFO - Revision ID: 0x0009 08:32:10 INFO - Displays: 08:32:10 INFO - Display: 08:32:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:32:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:32:10 INFO - Display Serial Number: 1600x1200 60 08:32:10 INFO - Main Display: Yes 08:32:10 INFO - Mirror: Off 08:32:10 INFO - Online: Yes 08:32:10 INFO - Rotation: Supported 08:32:10 INFO - Return code: 0 08:32:10 INFO - Running post-action listener: _resource_record_post_action 08:32:10 INFO - [mozharness: 2017-03-22 15:32:10.608386Z] Finished run-tests step (success) 08:32:10 INFO - Running post-run listener: _resource_record_post_run 08:32:10 INFO - Total resource usage - Wall time: 1200s; CPU: 54.0%; Read bytes: 39492096; Write bytes: 515309568; Read time: 386; Write time: 1693 08:32:10 INFO - TinderboxPrint: CPU usage
54.1% 08:32:10 INFO - TinderboxPrint: I/O read bytes / time
39,492,096 / 386 08:32:10 INFO - TinderboxPrint: I/O write bytes / time
515,309,568 / 1,693 08:32:10 INFO - TinderboxPrint: CPU idle
2,203.4 (45.9%) 08:32:10 INFO - TinderboxPrint: CPU system
966.2 (20.1%) 08:32:10 INFO - TinderboxPrint: CPU user
1,632.0 (34.0%) 08:32:10 INFO - TinderboxPrint: Swap in / out
250,748,928 / 0 08:32:10 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 208419328; Write bytes: 204130304; Read time: 15778; Write time: 427 08:32:10 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 35424768; Write bytes: 299960320; Read time: 355; Write time: 1228 08:32:11 INFO - Running post-run listener: _upload_blobber_files 08:32:11 INFO - Blob upload gear active. 08:32:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:32:11 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:32:11 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'] 08:32:11 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 08:32:11 INFO - (blobuploader) - INFO - Open directory for files ... 08:32:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:32:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:32:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:32:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:32:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:32:12 INFO - (blobuploader) - INFO - Done attempting. 08:32:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:32:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:32:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:32:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:32:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:32:13 INFO - (blobuploader) - INFO - Done attempting. 08:32:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:32:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:32:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:32:14 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:32:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:32:14 INFO - (blobuploader) - INFO - Done attempting. 08:32:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:32:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:32:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:32:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:32:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:32:16 INFO - (blobuploader) - INFO - Done attempting. 08:32:16 INFO - (blobuploader) - INFO - Iteration through files over. 08:32:16 INFO - Return code: 0 08:32:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:32:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:32:16 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ae7f9ee3197611ec61abff86f754d05d31f129af973f1c5b5056e64c0f8d289612d5a75230fac39b20767780162ecadbf6581a7f88433ae9d0c84be1e2009d63", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/33dde8f793b3f16323aab5d1ba6e346b7173f82de0a79664f7fc433a7cda0254b25ae07288b9ef32138f9e44bb13321afc86ba045c46bb9bf57cdc3ed3df23ea", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1a90f4a36a9ef40fffcf496229b88324bded756a00aa4751a38c2df2081b958117229a85fa1c644840a709966daa67688a478c91e31612c25ab5fcf6071057db", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/70abe0823f954d2656175242bc04c65c456b85253fc5443ce369d97ccdfa0cdc1e40593babe316b5ec6e43e6fa0fa0384b61133556c418ea77c3ec23f7e48d8d"} 08:32:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:32:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:32:16 INFO - Contents: 08:32:16 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ae7f9ee3197611ec61abff86f754d05d31f129af973f1c5b5056e64c0f8d289612d5a75230fac39b20767780162ecadbf6581a7f88433ae9d0c84be1e2009d63", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/33dde8f793b3f16323aab5d1ba6e346b7173f82de0a79664f7fc433a7cda0254b25ae07288b9ef32138f9e44bb13321afc86ba045c46bb9bf57cdc3ed3df23ea", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1a90f4a36a9ef40fffcf496229b88324bded756a00aa4751a38c2df2081b958117229a85fa1c644840a709966daa67688a478c91e31612c25ab5fcf6071057db", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/70abe0823f954d2656175242bc04c65c456b85253fc5443ce369d97ccdfa0cdc1e40593babe316b5ec6e43e6fa0fa0384b61133556c418ea77c3ec23f7e48d8d"} 08:32:16 INFO - Running post-run listener: copy_logs_to_upload_dir 08:32:16 INFO - Copying logs to upload dir... 08:32:16 INFO - mkdir: /builds/slave/test/build/upload/logs 08:32:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1284.196038 ========= master_lag: -0.15 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2017-03-22 08:32:16.184087) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-22 08:32:16.187642) ========= 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.7bhy4ILqLD/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.8B38FVUj5M/Listeners TMPDIR=/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ae7f9ee3197611ec61abff86f754d05d31f129af973f1c5b5056e64c0f8d289612d5a75230fac39b20767780162ecadbf6581a7f88433ae9d0c84be1e2009d63", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/33dde8f793b3f16323aab5d1ba6e346b7173f82de0a79664f7fc433a7cda0254b25ae07288b9ef32138f9e44bb13321afc86ba045c46bb9bf57cdc3ed3df23ea", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1a90f4a36a9ef40fffcf496229b88324bded756a00aa4751a38c2df2081b958117229a85fa1c644840a709966daa67688a478c91e31612c25ab5fcf6071057db", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/70abe0823f954d2656175242bc04c65c456b85253fc5443ce369d97ccdfa0cdc1e40593babe316b5ec6e43e6fa0fa0384b61133556c418ea77c3ec23f7e48d8d"} build_url:https://queue.taskcluster.net/v1/task/Pe-aGIinRvaB-MuJm7ikhQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011078 build_url: 'https://queue.taskcluster.net/v1/task/Pe-aGIinRvaB-MuJm7ikhQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ae7f9ee3197611ec61abff86f754d05d31f129af973f1c5b5056e64c0f8d289612d5a75230fac39b20767780162ecadbf6581a7f88433ae9d0c84be1e2009d63", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/33dde8f793b3f16323aab5d1ba6e346b7173f82de0a79664f7fc433a7cda0254b25ae07288b9ef32138f9e44bb13321afc86ba045c46bb9bf57cdc3ed3df23ea", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1a90f4a36a9ef40fffcf496229b88324bded756a00aa4751a38c2df2081b958117229a85fa1c644840a709966daa67688a478c91e31612c25ab5fcf6071057db", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/70abe0823f954d2656175242bc04c65c456b85253fc5443ce369d97ccdfa0cdc1e40593babe316b5ec6e43e6fa0fa0384b61133556c418ea77c3ec23f7e48d8d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-22 08:32:16.223204) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-22 08:32:16.223594) ========= 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.7bhy4ILqLD/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.8B38FVUj5M/Listeners TMPDIR=/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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.005115 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-22 08:32:16.273772) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-22 08:32:16.274154) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-22 08:32:16.274591) ========= ========= Total master_lag: 2.39 =========