builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0026 starttime: 1489539307.18 results: success (0) buildid: 20170314164236 builduid: 1f0032370c8b4056a942c2ad39708b53 revision: cef93bf5a0a15ab7a2dc96d0cee90a599a4eae76 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-14 17:55:07.182792) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-14 17:55:07.183303) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-14 17:55:07.183618) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-14 17:55:07.210944) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-14 17:55:07.211402) ========= 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.5bwEt4hO0b/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.I1bg8vdDKe/Listeners TMPDIR=/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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-14 17:55:07-- 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.1M=0.001s 2017-03-14 17:55:07 (14.1 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.182994 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-14 17:55:07.421332) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-14 17:55:07.421859) ========= 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.5bwEt4hO0b/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.I1bg8vdDKe/Listeners TMPDIR=/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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.027379 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-14 17:55:07.473753) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-14 17:55:07.474273) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev cef93bf5a0a15ab7a2dc96d0cee90a599a4eae76 --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 cef93bf5a0a15ab7a2dc96d0cee90a599a4eae76 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.5bwEt4hO0b/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.I1bg8vdDKe/Listeners TMPDIR=/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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-14 17:55:07,579 truncating revision to first 12 chars 2017-03-14 17:55:07,579 Setting DEBUG logging. 2017-03-14 17:55:07,579 attempt 1/10 2017-03-14 17:55:07,579 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/cef93bf5a0a1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-14 17:55:08,283 unpacking tar archive at: mozilla-central-cef93bf5a0a1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.980349 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-14 17:55:08.481200) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-14 17:55:08.481629) ========= script_repo_revision: cef93bf5a0a15ab7a2dc96d0cee90a599a4eae76 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-14 17:55:08.482079) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-14 17:55:08.482362) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-14 17:55:08.503207) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2017-03-14 17:55:08.503653) ========= /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.5bwEt4hO0b/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.I1bg8vdDKe/Listeners TMPDIR=/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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 17:55:08 INFO - MultiFileLogger online at 20170314 17:55:08 in /builds/slave/test 17:55:08 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 17:55:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:55:08 INFO - {'append_to_log': False, 17:55:08 INFO - 'base_work_dir': '/builds/slave/test', 17:55:08 INFO - 'blob_upload_branch': 'Firefox', 17:55:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:55:08 INFO - 'branch': 'Firefox', 17:55:08 INFO - 'buildbot_json_path': 'buildprops.json', 17:55:08 INFO - 'config_files': ('talos/mac_config.py',), 17:55:08 INFO - 'default_actions': ('clobber', 17:55:08 INFO - 'read-buildbot-config', 17:55:08 INFO - 'download-and-extract', 17:55:08 INFO - 'populate-webroot', 17:55:08 INFO - 'create-virtualenv', 17:55:08 INFO - 'install', 17:55:08 INFO - 'run-tests'), 17:55:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:55:08 INFO - 'download_minidump_stackwalk': True, 17:55:08 INFO - 'download_symbols': 'ondemand', 17:55:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:55:08 INFO - 'tooltool.py': '/tools/tooltool.py', 17:55:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:55:08 INFO - '/tools/misc-python/virtualenv.py')}, 17:55:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:55:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:55:08 INFO - 'gecko_profile': False, 17:55:08 INFO - 'gecko_profile_interval': 0, 17:55:08 INFO - 'installer_path': 'installer.exe', 17:55:08 INFO - 'log_level': 'info', 17:55:08 INFO - 'log_name': 'talos', 17:55:08 INFO - 'log_to_console': True, 17:55:08 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:55:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:55:08 INFO - 'opt_config_files': (), 17:55:08 INFO - 'pip_index': False, 17:55:08 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:55:08 INFO - 'cmd': ('bash', 17:55:08 INFO - '-c', 17:55:08 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:55:08 INFO - 'enabled': True, 17:55:08 INFO - 'halt_on_failure': False, 17:55:08 INFO - 'name': 'check_screen_resolution'},), 17:55:08 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:55:08 INFO - 'cmd': ('bash', 17:55:08 INFO - '-c', 17:55:08 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:55:08 INFO - 'enabled': True, 17:55:08 INFO - 'halt_on_failure': False, 17:55:08 INFO - 'name': 'check_screen_resolution'},), 17:55:08 INFO - 'run_cmd_checks_enabled': True, 17:55:08 INFO - 'suite': 'dromaeojs-e10s', 17:55:08 INFO - 'system_bits': '32', 17:55:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:55:08 INFO - 'title': 't-yosemite-r7-0026', 17:55:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:55:08 INFO - 'use_talos_json': True, 17:55:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:55:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:55:08 INFO - 'work_dir': 'build'} 17:55:08 INFO - [mozharness: 2017-03-15 00:55:08.725659Z] Running clobber step. 17:55:08 INFO - Running pre-action listener: _resource_record_pre_action 17:55:08 INFO - Running main action method: clobber 17:55:08 INFO - rmtree: /builds/slave/test/build 17:55:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:55:11 INFO - Running post-action listener: _resource_record_post_action 17:55:11 INFO - [mozharness: 2017-03-15 00:55:11.169252Z] Finished clobber step (success) 17:55:11 INFO - [mozharness: 2017-03-15 00:55:11.169409Z] Running read-buildbot-config step. 17:55:11 INFO - Running pre-action listener: _resource_record_pre_action 17:55:11 INFO - Running main action method: read_buildbot_config 17:55:11 INFO - Using buildbot properties: 17:55:11 INFO - { 17:55:11 INFO - "project": "", 17:55:11 INFO - "product": "firefox", 17:55:11 INFO - "script_repo_revision": "production", 17:55:11 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 17:55:11 INFO - "repository": "", 17:55:11 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 17:55:11 INFO - "buildid": "20170314164236", 17:55:11 INFO - "pgo_build": "False", 17:55:11 INFO - "basedir": "/builds/slave/test", 17:55:11 INFO - "buildnumber": 175, 17:55:11 INFO - "slavename": "t-yosemite-r7-0026", 17:55:11 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 17:55:11 INFO - "platform": "yosemite_r7", 17:55:11 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 17:55:11 INFO - "branch": "mozilla-central", 17:55:11 INFO - "repo_path": "mozilla-central", 17:55:11 INFO - "revision": "cef93bf5a0a15ab7a2dc96d0cee90a599a4eae76", 17:55:11 INFO - "stage_platform": "macosx64", 17:55:11 INFO - "builduid": "1f0032370c8b4056a942c2ad39708b53", 17:55:11 INFO - "slavebuilddir": "test" 17:55:11 INFO - } 17:55:11 INFO - Found installer url https://queue.taskcluster.net/v1/task/eUbnioplRtahrrdxjtWT1Q/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 17:55:11 INFO - Running post-action listener: _resource_record_post_action 17:55:11 INFO - [mozharness: 2017-03-15 00:55:11.172793Z] Finished read-buildbot-config step (success) 17:55:11 INFO - [mozharness: 2017-03-15 00:55:11.172933Z] Running download-and-extract step. 17:55:11 INFO - Running pre-action listener: _resource_record_pre_action 17:55:11 INFO - Running main action method: download_and_extract 17:55:11 INFO - mkdir: /builds/slave/test/build/tests 17:55:11 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')]} 17:55:11 INFO - trying https://queue.taskcluster.net/v1/task/eUbnioplRtahrrdxjtWT1Q/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 17:55:11 INFO - Downloading https://queue.taskcluster.net/v1/task/eUbnioplRtahrrdxjtWT1Q/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 17:55:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eUbnioplRtahrrdxjtWT1Q/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 17:55:12 INFO - Downloaded 1199 bytes. 17:55:12 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 17:55:12 INFO - Using the following test package requirements: 17:55:12 INFO - {u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 17:55:12 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:55:12 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 17:55:12 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:55:12 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 17:55:12 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:55:12 INFO - u'jsshell-mac.zip'], 17:55:12 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:55:12 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 17:55:12 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 17:55:12 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:55:12 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 17:55:12 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:55:12 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 17:55:12 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:55:12 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 17:55:12 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:55:12 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 17:55:12 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 17:55:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eUbnioplRtahrrdxjtWT1Q/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 17:55:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eUbnioplRtahrrdxjtWT1Q/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:55:12 INFO - Fetch https://queue.taskcluster.net/v1/task/eUbnioplRtahrrdxjtWT1Q/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 17:55:13 INFO - Expected file size: 52470989 17:55:13 INFO - Obtained file size: 52470989 17:55:30 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 17:55:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eUbnioplRtahrrdxjtWT1Q/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 17:55:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eUbnioplRtahrrdxjtWT1Q/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:55:30 INFO - Fetch https://queue.taskcluster.net/v1/task/eUbnioplRtahrrdxjtWT1Q/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 17:55:32 INFO - Expected file size: 52470989 17:55:32 INFO - Obtained file size: 52470989 17:55:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eUbnioplRtahrrdxjtWT1Q/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 17:55:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eUbnioplRtahrrdxjtWT1Q/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 17:55:47 INFO - Fetch https://queue.taskcluster.net/v1/task/eUbnioplRtahrrdxjtWT1Q/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 17:55:48 INFO - Expected file size: 14404452 17:55:48 INFO - Obtained file size: 14404452 17:55: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')]} 17:55:49 INFO - trying https://queue.taskcluster.net/v1/task/eUbnioplRtahrrdxjtWT1Q/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 17:55:49 INFO - Downloading https://queue.taskcluster.net/v1/task/eUbnioplRtahrrdxjtWT1Q/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 17:55:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eUbnioplRtahrrdxjtWT1Q/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 17:55:51 INFO - Downloaded 74991064 bytes. 17:55:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eUbnioplRtahrrdxjtWT1Q/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 17:55:51 INFO - mkdir: /builds/slave/test/properties 17:55:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:55:51 INFO - Writing to file /builds/slave/test/properties/build_url 17:55:51 INFO - Contents: 17:55:51 INFO - build_url:https://queue.taskcluster.net/v1/task/eUbnioplRtahrrdxjtWT1Q/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 17:55:52 INFO - Running post-action listener: _resource_record_post_action 17:55:52 INFO - Running post-action listener: set_extra_try_arguments 17:55:52 INFO - [mozharness: 2017-03-15 00:55:52.036568Z] Finished download-and-extract step (success) 17:55:52 INFO - [mozharness: 2017-03-15 00:55:52.036698Z] Running populate-webroot step. 17:55:52 INFO - Running pre-action listener: _resource_record_pre_action 17:55:52 INFO - Running main action method: populate_webroot 17:55:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:55:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:55:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:55:52 INFO - '--tppagecycles', 17:55:52 INFO - '7'], 17:55:52 INFO - 'tests': ['tsvgm']}}, 17:55:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:55:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:55:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:55:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:55:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:55:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:55:52 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 17:55:52 INFO - 'talos_options': ['--disable-e10s'], 17:55:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:55:52 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:55:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:55:52 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 17:55:52 INFO - 'talos_options': ['--disable-e10s'], 17:55:52 INFO - 'tests': ['damp', 'tps']}, 17:55:52 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:55:52 INFO - 'tests': ['damp', 'tps']}, 17:55:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:55:52 INFO - 'tests': ['dromaeo_dom']}, 17:55:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:55:52 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:55:52 INFO - 'tests': ['basic_compositor_video']}, 17:55:52 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:55:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:55:52 INFO - 'tests': ['a11yr', 17:55:52 INFO - 'ts_paint', 17:55:52 INFO - 'tpaint', 17:55:52 INFO - 'sessionrestore', 17:55:52 INFO - 'sessionrestore_no_auto_restore', 17:55:52 INFO - 'tabpaint']}, 17:55:52 INFO - 'other-e10s': {'tests': ['a11yr', 17:55:52 INFO - 'ts_paint', 17:55:52 INFO - 'tpaint', 17:55:52 INFO - 'sessionrestore', 17:55:52 INFO - 'sessionrestore_no_auto_restore', 17:55:52 INFO - 'tabpaint']}, 17:55:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:55:52 INFO - 'ts_paint', 17:55:52 INFO - 'tpaint', 17:55:52 INFO - 'sessionrestore', 17:55:52 INFO - 'sessionrestore_no_auto_restore', 17:55:52 INFO - 'tabpaint']}, 17:55:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:55:52 INFO - 'ts_paint', 17:55:52 INFO - 'tpaint', 17:55:52 INFO - 'sessionrestore', 17:55:52 INFO - 'sessionrestore_no_auto_restore', 17:55:52 INFO - 'tabpaint']}, 17:55:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:55:52 INFO - 'tests': ['a11yr', 17:55:52 INFO - 'ts_paint', 17:55:52 INFO - 'tpaint', 17:55:52 INFO - 'sessionrestore', 17:55:52 INFO - 'sessionrestore_no_auto_restore', 17:55:52 INFO - 'tabpaint']}, 17:55:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:55:52 INFO - 'tests': ['a11yr', 17:55:52 INFO - 'ts_paint', 17:55:52 INFO - 'tpaint', 17:55:52 INFO - 'sessionrestore', 17:55:52 INFO - 'sessionrestore_no_auto_restore', 17:55:52 INFO - 'tabpaint']}, 17:55:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:55:52 INFO - 'tests': ['tsvgx', 17:55:52 INFO - 'tsvgr_opacity', 17:55:52 INFO - 'tart', 17:55:52 INFO - 'tscrollx', 17:55:52 INFO - 'cart', 17:55:52 INFO - 'tsvg_static']}, 17:55:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:55:52 INFO - 'tsvgr_opacity', 17:55:52 INFO - 'tart', 17:55:52 INFO - 'tscrollx', 17:55:52 INFO - 'cart', 17:55:52 INFO - 'tsvg_static']}, 17:55:52 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 17:55:52 INFO - 'talos_options': ['--disable-e10s'], 17:55:52 INFO - 'tests': ['tp5o']}, 17:55:52 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:55:52 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 17:55:52 INFO - 'talos_options': ['--disable-e10s', 17:55:52 INFO - '--xperf_path', 17:55:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:55:52 INFO - 'tests': ['tp5n']}, 17:55:52 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:55:52 INFO - 'talos_options': ['--xperf_path', 17:55:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:55:52 INFO - 'tests': ['tp5n']}}, 17:55:52 INFO - 'talos.zip': {'path': '', 17:55:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:55:52 INFO - Running post-action listener: _resource_record_post_action 17:55:52 INFO - [mozharness: 2017-03-15 00:55:52.055393Z] Finished populate-webroot step (success) 17:55:52 INFO - [mozharness: 2017-03-15 00:55:52.055530Z] Running create-virtualenv step. 17:55:52 INFO - Running pre-action listener: _resource_record_pre_action 17:55:52 INFO - Running main action method: create_virtualenv 17:55:52 INFO - Creating virtualenv /builds/slave/test/build/venv 17:55:52 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 17:55:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:55:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:55:52 INFO - Using real prefix '/tools/python27' 17:55:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:55:52 INFO - Installing distribute.............................................................................................................................................................................................done. 17:55:55 INFO - Installing pip.................done. 17:55:55 INFO - Return code: 0 17:55:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:55:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:55:56 INFO - Reading from file tmpfile_stdout 17:55:56 INFO - Output received: 17:55:56 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) 17:55:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:55:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:55:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:55:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:55:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:55:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:55:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:55:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104eceb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ed1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb19846cf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104cacd30>, '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 0x104bd3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104ca1be8>, '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.5bwEt4hO0b/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.I1bg8vdDKe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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 17:55:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:55:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:55:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5bwEt4hO0b/Render', 17:55:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:55:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:55:56 INFO - 'HOME': '/Users/cltbld', 17:55:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:55:56 INFO - 'LOGNAME': 'cltbld', 17:55:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:55:56 INFO - 'MOZ_NO_REMOTE': '1', 17:55:56 INFO - 'NO_EM_RESTART': '1', 17:55:56 INFO - 'PAGER': '/bin/cat', 17:55:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:55:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:55:56 INFO - 'PWD': '/builds/slave/test', 17:55:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:55:56 INFO - 'SHELL': '/bin/bash', 17:55:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.I1bg8vdDKe/Listeners', 17:55:56 INFO - 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', 17:55:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:55:56 INFO - 'USER': 'cltbld', 17:55:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:55:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:55:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:55:56 INFO - 'XPC_FLAGS': '0x0', 17:55:56 INFO - 'XPC_SERVICE_NAME': '0', 17:55:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:55:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:55:56 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 17:55:56 INFO - Cleaning up... 17:55:56 INFO - Return code: 0 17:55:56 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:55:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:55:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:55:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:55:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:55:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:55:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:55:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x104eceb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ed1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb19846cf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104cacd30>, '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 0x104bd3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104ca1be8>, '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.5bwEt4hO0b/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.I1bg8vdDKe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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 17:55:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 17:55:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 17:55:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5bwEt4hO0b/Render', 17:55:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:55:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:55:56 INFO - 'HOME': '/Users/cltbld', 17:55:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:55:56 INFO - 'LOGNAME': 'cltbld', 17:55:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:55:56 INFO - 'MOZ_NO_REMOTE': '1', 17:55:56 INFO - 'NO_EM_RESTART': '1', 17:55:56 INFO - 'PAGER': '/bin/cat', 17:55:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:55:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:55:56 INFO - 'PWD': '/builds/slave/test', 17:55:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:55:56 INFO - 'SHELL': '/bin/bash', 17:55:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.I1bg8vdDKe/Listeners', 17:55:56 INFO - 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', 17:55:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:55:56 INFO - 'USER': 'cltbld', 17:55:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:55:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:55:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:55:56 INFO - 'XPC_FLAGS': '0x0', 17:55:56 INFO - 'XPC_SERVICE_NAME': '0', 17:55:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:55:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:55:56 INFO - Downloading/unpacking psutil>=3.1.1 17:55: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 17:55: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 17:55: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 17:55: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 17:55: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 17:55: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 17:56:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:56:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:56:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:56:00 INFO - Installing collected packages: psutil 17:56:00 INFO - Running setup.py install for psutil 17:56:00 INFO - building 'psutil._psutil_osx' extension 17:56:00 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 17:56:00 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 17:56:00 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 17:56:01 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 17:56:01 INFO - building 'psutil._psutil_posix' extension 17:56:01 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 17:56:01 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:56:01 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:56:01 INFO - ^ 17:56:01 INFO - 1 warning generated. 17:56:01 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 17:56:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:56:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:56:01 INFO - Successfully installed psutil 17:56:01 INFO - Cleaning up... 17:56:01 INFO - Return code: 0 17:56:01 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:56:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:56:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:56:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:56:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:56:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:56:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:56:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104eceb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ed1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb19846cf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104cacd30>, '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 0x104bd3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104ca1be8>, '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.5bwEt4hO0b/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.I1bg8vdDKe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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 17:56:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:56:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 17:56:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5bwEt4hO0b/Render', 17:56:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:56:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:56:01 INFO - 'HOME': '/Users/cltbld', 17:56:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:56:01 INFO - 'LOGNAME': 'cltbld', 17:56:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:56:01 INFO - 'MOZ_NO_REMOTE': '1', 17:56:01 INFO - 'NO_EM_RESTART': '1', 17:56:01 INFO - 'PAGER': '/bin/cat', 17:56:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:56:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:56:01 INFO - 'PWD': '/builds/slave/test', 17:56:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:56:01 INFO - 'SHELL': '/bin/bash', 17:56:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.I1bg8vdDKe/Listeners', 17:56:01 INFO - 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', 17:56:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:56:01 INFO - 'USER': 'cltbld', 17:56:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:56:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:56:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:56:01 INFO - 'XPC_FLAGS': '0x0', 17:56:01 INFO - 'XPC_SERVICE_NAME': '0', 17:56:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:56:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:56:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:56:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:56:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:56:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:56:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:56:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:56:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:56:04 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:56:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:56:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:56:04 INFO - Installing collected packages: mozsystemmonitor 17:56:04 INFO - Running setup.py install for mozsystemmonitor 17:56:04 INFO - Successfully installed mozsystemmonitor 17:56:04 INFO - Cleaning up... 17:56:04 INFO - Return code: 0 17:56:04 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:56:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:56:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:56:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:56:05 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')]} 17:56:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:56:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:56:05 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 0x104eceb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ed1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb19846cf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104cacd30>, '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 0x104bd3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104ca1be8>, '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.5bwEt4hO0b/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.I1bg8vdDKe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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 17:56:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:56:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 17:56:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5bwEt4hO0b/Render', 17:56:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:56:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:56:05 INFO - 'HOME': '/Users/cltbld', 17:56:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:56:05 INFO - 'LOGNAME': 'cltbld', 17:56:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:56:05 INFO - 'MOZ_NO_REMOTE': '1', 17:56:05 INFO - 'NO_EM_RESTART': '1', 17:56:05 INFO - 'PAGER': '/bin/cat', 17:56:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:56:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:56:05 INFO - 'PWD': '/builds/slave/test', 17:56:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:56:05 INFO - 'SHELL': '/bin/bash', 17:56:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.I1bg8vdDKe/Listeners', 17:56:05 INFO - 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', 17:56:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:56:05 INFO - 'USER': 'cltbld', 17:56:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:56:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:56:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:56:05 INFO - 'XPC_FLAGS': '0x0', 17:56:05 INFO - 'XPC_SERVICE_NAME': '0', 17:56:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:56:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:56:05 INFO - Downloading/unpacking jsonschema==2.5.1 17:56: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 17:56: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 17:56: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 17:56: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 17:56: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 17:56: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 17:56:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:56:08 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:56:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:56:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:56:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:56:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:56:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:56:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:56:09 INFO - Downloading functools32-3.2.3-2.tar.gz 17:56:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:56:09 INFO - warning: no files found matching '*.txt' 17:56:09 INFO - no previously-included directories found matching 'build' 17:56:09 INFO - no previously-included directories found matching 'dist' 17:56:09 INFO - no previously-included directories found matching '.git*' 17:56:09 INFO - Installing collected packages: jsonschema, functools32 17:56:09 INFO - Running setup.py install for functools32 17:56:09 INFO - warning: no files found matching '*.txt' 17:56:09 INFO - no previously-included directories found matching 'build' 17:56:09 INFO - no previously-included directories found matching 'dist' 17:56:09 INFO - no previously-included directories found matching '.git*' 17:56:09 INFO - Successfully installed jsonschema functools32 17:56:09 INFO - Cleaning up... 17:56:09 INFO - Return code: 0 17:56:09 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:56:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:56:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:56:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:56:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:56:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:56:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:56:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x104eceb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ed1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb19846cf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104cacd30>, '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 0x104bd3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104ca1be8>, '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.5bwEt4hO0b/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.I1bg8vdDKe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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 17:56:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 17:56:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 17:56:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5bwEt4hO0b/Render', 17:56:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:56:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:56:09 INFO - 'HOME': '/Users/cltbld', 17:56:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:56:09 INFO - 'LOGNAME': 'cltbld', 17:56:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:56:09 INFO - 'MOZ_NO_REMOTE': '1', 17:56:09 INFO - 'NO_EM_RESTART': '1', 17:56:09 INFO - 'PAGER': '/bin/cat', 17:56:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:56:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:56:09 INFO - 'PWD': '/builds/slave/test', 17:56:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:56:09 INFO - 'SHELL': '/bin/bash', 17:56:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.I1bg8vdDKe/Listeners', 17:56:09 INFO - 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', 17:56:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:56:09 INFO - 'USER': 'cltbld', 17:56:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:56:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:56:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:56:09 INFO - 'XPC_FLAGS': '0x0', 17:56:09 INFO - 'XPC_SERVICE_NAME': '0', 17:56:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:56:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:56:09 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:56:09 INFO - Cleaning up... 17:56:09 INFO - Return code: 0 17:56:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:56:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:56:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:56:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:56:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:56:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:56:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:56:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x104eceb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ed1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb19846cf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104cacd30>, '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 0x104bd3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104ca1be8>, '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.5bwEt4hO0b/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.I1bg8vdDKe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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 17:56:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:56:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:56:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5bwEt4hO0b/Render', 17:56:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:56:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:56:09 INFO - 'HOME': '/Users/cltbld', 17:56:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:56:09 INFO - 'LOGNAME': 'cltbld', 17:56:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:56:09 INFO - 'MOZ_NO_REMOTE': '1', 17:56:09 INFO - 'NO_EM_RESTART': '1', 17:56:09 INFO - 'PAGER': '/bin/cat', 17:56:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:56:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:56:09 INFO - 'PWD': '/builds/slave/test', 17:56:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:56:09 INFO - 'SHELL': '/bin/bash', 17:56:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.I1bg8vdDKe/Listeners', 17:56:09 INFO - 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', 17:56:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:56:09 INFO - 'USER': 'cltbld', 17:56:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:56:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:56:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:56:09 INFO - 'XPC_FLAGS': '0x0', 17:56:09 INFO - 'XPC_SERVICE_NAME': '0', 17:56:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:56:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:56:10 INFO - Downloading/unpacking blobuploader==1.2.4 17:56:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:56:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:56:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:56:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:56:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:56:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:56:12 INFO - Downloading blobuploader-1.2.4.tar.gz 17:56:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:56:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:56:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:56:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:56:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:56:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:56:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:56:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:56:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:56:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:56:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:56:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:56:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:56:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:56:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:56:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:56:14 INFO - Downloading docopt-0.6.1.tar.gz 17:56:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:56:14 INFO - Installing collected packages: blobuploader, requests, docopt 17:56:14 INFO - Running setup.py install for blobuploader 17:56:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:56:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:56:14 INFO - Running setup.py install for requests 17:56:14 INFO - Running setup.py install for docopt 17:56:14 INFO - Successfully installed blobuploader requests docopt 17:56:14 INFO - Cleaning up... 17:56:15 INFO - Return code: 0 17:56:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:56:15 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')]} 17:56:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:56:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:56:15 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')]} 17:56:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:56:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:56:15 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 0x104eceb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ed1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb19846cf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104cacd30>, '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 0x104bd3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104ca1be8>, '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.5bwEt4hO0b/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.I1bg8vdDKe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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 17:56:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:56:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:56:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5bwEt4hO0b/Render', 17:56:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:56:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:56:15 INFO - 'HOME': '/Users/cltbld', 17:56:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:56:15 INFO - 'LOGNAME': 'cltbld', 17:56:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:56:15 INFO - 'MOZ_NO_REMOTE': '1', 17:56:15 INFO - 'NO_EM_RESTART': '1', 17:56:15 INFO - 'PAGER': '/bin/cat', 17:56:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:56:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:56:15 INFO - 'PWD': '/builds/slave/test', 17:56:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:56:15 INFO - 'SHELL': '/bin/bash', 17:56:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.I1bg8vdDKe/Listeners', 17:56:15 INFO - 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', 17:56:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:56:15 INFO - 'USER': 'cltbld', 17:56:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:56:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:56:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:56:15 INFO - 'XPC_FLAGS': '0x0', 17:56:15 INFO - 'XPC_SERVICE_NAME': '0', 17:56:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:56:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:56:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:56:15 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-m3mAYS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:56:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:56:15 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-rdLHYc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:56:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:56:15 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-ZZzksE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:56:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:56:15 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-HCr0X9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:56:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:56:15 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-Ia9GcC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:56:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:56:15 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-tSI9Se-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:56:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:56:15 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-exgmu3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:56:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:56:16 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-z_DTQf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:56:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:56:16 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-T84Wne-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:56:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:56:16 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-GQlL3i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:56:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:56:16 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-MS2Pr2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:56:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:56:16 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-mndG5P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:56:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:56:16 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-uzq00J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:56:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:56:16 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-o89QYG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:56:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:56:16 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-QCv3_G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:56:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:56:16 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-J0RzBp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:56:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:56:16 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-554ekr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:56:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:56:17 INFO - Running setup.py install for manifestparser 17:56:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:56:17 INFO - Running setup.py install for mozcrash 17:56:17 INFO - Running setup.py install for mozdebug 17:56:17 INFO - Running setup.py install for mozdevice 17:56:17 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:56:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:56:17 INFO - Running setup.py install for mozfile 17:56:17 INFO - Running setup.py install for mozhttpd 17:56:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:56:17 INFO - Running setup.py install for mozinfo 17:56:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:56:18 INFO - Running setup.py install for mozInstall 17:56:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:56:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:56:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:56:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:56:18 INFO - Running setup.py install for mozleak 17:56:18 INFO - Running setup.py install for mozlog 17:56:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:56:18 INFO - Running setup.py install for moznetwork 17:56:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:56:18 INFO - Running setup.py install for mozprocess 17:56:18 INFO - Running setup.py install for mozprofile 17:56:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:56:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:56:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:56:19 INFO - Running setup.py install for mozrunner 17:56:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:56:19 INFO - Running setup.py install for mozscreenshot 17:56:19 INFO - Running setup.py install for moztest 17:56:19 INFO - Running setup.py install for mozversion 17:56:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:56:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:56:19 INFO - Cleaning up... 17:56:19 INFO - Return code: 0 17:56:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:56:19 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')]} 17:56:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:56:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:56:19 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')]} 17:56:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:56:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:56:19 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 0x104eceb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ed1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb19846cf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104cacd30>, '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 0x104bd3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104ca1be8>, '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.5bwEt4hO0b/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.I1bg8vdDKe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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 17:56:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:56:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:56:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5bwEt4hO0b/Render', 17:56:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:56:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:56:19 INFO - 'HOME': '/Users/cltbld', 17:56:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:56:19 INFO - 'LOGNAME': 'cltbld', 17:56:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:56:19 INFO - 'MOZ_NO_REMOTE': '1', 17:56:19 INFO - 'NO_EM_RESTART': '1', 17:56:19 INFO - 'PAGER': '/bin/cat', 17:56:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:56:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:56:19 INFO - 'PWD': '/builds/slave/test', 17:56:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:56:19 INFO - 'SHELL': '/bin/bash', 17:56:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.I1bg8vdDKe/Listeners', 17:56:19 INFO - 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', 17:56:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:56:19 INFO - 'USER': 'cltbld', 17:56:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:56:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:56:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:56:19 INFO - 'XPC_FLAGS': '0x0', 17:56:19 INFO - 'XPC_SERVICE_NAME': '0', 17:56:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:56:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:56:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:56:19 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-WInCmw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:56:20 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 17:56:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:56:20 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-FlIfNP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:56:20 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)) 17:56:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:56:20 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-o5oqIh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:56:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:56:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:56:20 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-LO1ePi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:56:20 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)) 17:56:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:56:20 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-FXjnUz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:56:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 17:56:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:56:20 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-1m7cft-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:56:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 17:56:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:56:20 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-Fbrfoi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:56:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 17:56:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:56:20 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-sP33qi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:56:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 17:56:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:56:20 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-8FxnTL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:56:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 17:56:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:56:20 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-hEpf3p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:56:20 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)) 17:56:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:56:20 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-PCVjMZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:56:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 17:56:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:56:21 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-kply76-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:56:21 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)) 17:56:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:56:21 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-w_N3tB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:56:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 17:56:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:56:21 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-GmgrGT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:56:21 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)) 17:56:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:56:21 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-f8WK_8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:56:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 17:56:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:56:21 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-BbEg5W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:56:21 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)) 17:56:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:56:21 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-Y93M7u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:56:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 17:56:21 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)) 17:56:21 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)) 17:56:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:56:21 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)) 17:56:21 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)) 17:56:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:56:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:56:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:56:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:56:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:56:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:56:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:56:24 INFO - Downloading blessings-1.6.tar.gz 17:56:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:56:24 INFO - Installing collected packages: blessings 17:56:24 INFO - Running setup.py install for blessings 17:56:24 INFO - Successfully installed blessings 17:56:24 INFO - Cleaning up... 17:56:24 INFO - Return code: 0 17:56:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:56:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:56:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:56:25 INFO - Reading from file tmpfile_stdout 17:56:25 INFO - Current package versions: 17:56:25 INFO - blessings == 1.6 17:56:25 INFO - blobuploader == 1.2.4 17:56:25 INFO - docopt == 0.6.1 17:56:25 INFO - functools32 == 3.2.3-2 17:56:25 INFO - jsonschema == 2.5.1 17:56:25 INFO - manifestparser == 1.1 17:56:25 INFO - mozInstall == 1.12 17:56:25 INFO - mozcrash == 1.0 17:56:25 INFO - mozdebug == 0.1 17:56:25 INFO - mozdevice == 0.49 17:56:25 INFO - mozfile == 1.2 17:56:25 INFO - mozhttpd == 0.7 17:56:25 INFO - mozinfo == 0.9 17:56:25 INFO - mozleak == 0.1 17:56:25 INFO - mozlog == 3.4 17:56:25 INFO - moznetwork == 0.27 17:56:25 INFO - mozprocess == 0.25 17:56:25 INFO - mozprofile == 0.28 17:56:25 INFO - mozrunner == 6.13 17:56:25 INFO - mozscreenshot == 0.1 17:56:25 INFO - mozsystemmonitor == 0.3 17:56:25 INFO - moztest == 0.8 17:56:25 INFO - mozversion == 1.4 17:56:25 INFO - psutil == 3.1.1 17:56:25 INFO - requests == 1.2.3 17:56:25 INFO - wsgiref == 0.1.2 17:56:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:56:25 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')]} 17:56:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:56:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:56:25 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')]} 17:56:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:56:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:56:25 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 0x104eceb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ed1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb19846cf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104cacd30>, '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 0x104bd3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104ca1be8>, '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.5bwEt4hO0b/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.I1bg8vdDKe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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 17:56:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 17:56:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:56:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5bwEt4hO0b/Render', 17:56:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:56:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:56:25 INFO - 'HOME': '/Users/cltbld', 17:56:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:56:25 INFO - 'LOGNAME': 'cltbld', 17:56:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:56:25 INFO - 'MOZ_NO_REMOTE': '1', 17:56:25 INFO - 'NO_EM_RESTART': '1', 17:56:25 INFO - 'PAGER': '/bin/cat', 17:56:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:56:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:56:25 INFO - 'PWD': '/builds/slave/test', 17:56:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:56:25 INFO - 'SHELL': '/bin/bash', 17:56:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.I1bg8vdDKe/Listeners', 17:56:25 INFO - 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', 17:56:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:56:25 INFO - 'USER': 'cltbld', 17:56:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:56:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:56:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:56:25 INFO - 'XPC_FLAGS': '0x0', 17:56:25 INFO - 'XPC_SERVICE_NAME': '0', 17:56:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:56:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:56:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:56:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 17:56:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 17:56:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:56:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 17:56:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 17:56:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 17:56:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 17:56:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 17:56:25 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:56:25 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:56:25 INFO - Cleaning up... 17:56:25 INFO - Return code: 0 17:56:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:56:25 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')]} 17:56:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:56:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:56:25 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')]} 17:56:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:56:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:56:25 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 0x104eceb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ed1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb19846cf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104cacd30>, '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 0x104bd3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104ca1be8>, '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.5bwEt4hO0b/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.I1bg8vdDKe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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 17:56:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:56:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:56:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5bwEt4hO0b/Render', 17:56:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:56:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:56:25 INFO - 'HOME': '/Users/cltbld', 17:56:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:56:25 INFO - 'LOGNAME': 'cltbld', 17:56:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:56:25 INFO - 'MOZ_NO_REMOTE': '1', 17:56:25 INFO - 'NO_EM_RESTART': '1', 17:56:25 INFO - 'PAGER': '/bin/cat', 17:56:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:56:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:56:25 INFO - 'PWD': '/builds/slave/test', 17:56:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:56:25 INFO - 'SHELL': '/bin/bash', 17:56:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.I1bg8vdDKe/Listeners', 17:56:25 INFO - 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', 17:56:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:56:25 INFO - 'USER': 'cltbld', 17:56:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:56:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:56:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:56:25 INFO - 'XPC_FLAGS': '0x0', 17:56:25 INFO - 'XPC_SERVICE_NAME': '0', 17:56:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:56:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:56:25 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:56:25 INFO - Cleaning up... 17:56:25 INFO - Return code: 0 17:56:25 INFO - Running post-action listener: _resource_record_post_action 17:56:25 INFO - Running post-action listener: _start_resource_monitoring 17:56:25 INFO - Starting resource monitoring. 17:56:25 INFO - [mozharness: 2017-03-15 00:56:25.635154Z] Finished create-virtualenv step (success) 17:56:25 INFO - [mozharness: 2017-03-15 00:56:25.636128Z] Running install step. 17:56:25 INFO - Running pre-action listener: _resource_record_pre_action 17:56:25 INFO - Running main action method: install 17:56:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:56:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:56:25 INFO - Reading from file tmpfile_stdout 17:56:25 INFO - Detecting whether we're running mozinstall >=1.0... 17:56:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:56:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:56:26 INFO - Reading from file tmpfile_stdout 17:56:26 INFO - Output received: 17:56:26 INFO - Usage: mozinstall [options] installer 17:56:26 INFO - Options: 17:56:26 INFO - -h, --help show this help message and exit 17:56:26 INFO - -d DEST, --destination=DEST 17:56:26 INFO - Directory to install application into. [default: 17:56:26 INFO - "/builds/slave/test"] 17:56:26 INFO - --app=APP Application being installed. [default: firefox] 17:56:26 INFO - mkdir: /builds/slave/test/build/application 17:56:26 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'] 17:56:26 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 17:56:46 INFO - Reading from file tmpfile_stdout 17:56:46 INFO - Output received: 17:56:46 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 17:56:46 INFO - Running post-action listener: _resource_record_post_action 17:56:46 INFO - [mozharness: 2017-03-15 00:56:46.283280Z] Finished install step (success) 17:56:46 INFO - [mozharness: 2017-03-15 00:56:46.283385Z] Running run-tests step. 17:56:46 INFO - Running pre-action listener: _resource_record_pre_action 17:56:46 INFO - Running main action method: run_tests 17:56:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:56:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:56:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:56:46 INFO - 2017-03-14 17:56:46.296 screenresolution[1623:7553] starting screenresolution argv=screenresolution get 17:56:46 INFO - 2017-03-14 17:56:46.299 screenresolution[1623:7553] Display 0: 1600x1200x32@60 17:56:46 INFO - 2017-03-14 17:56:46.304 screenresolution[1624:7555] starting screenresolution argv=screenresolution list 17:56:46 INFO - Available Modes on Display 0 17:56:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:56:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:56:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:56:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:56:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:56:46 INFO - Intel Iris: 17:56:46 INFO - Chipset Model: Intel Iris 17:56:46 INFO - Type: GPU 17:56:46 INFO - Bus: Built-In 17:56:46 INFO - VRAM (Dynamic, Max): 1536 MB 17:56:46 INFO - Vendor: Intel (0x8086) 17:56:46 INFO - Device ID: 0x0a2e 17:56:46 INFO - Revision ID: 0x0009 17:56:46 INFO - Displays: 17:56:46 INFO - Display: 17:56:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:56:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:56:46 INFO - Display Serial Number: 1600x1200 60 17:56:46 INFO - Main Display: Yes 17:56:46 INFO - Mirror: Off 17:56:46 INFO - Online: Yes 17:56:46 INFO - Rotation: Supported 17:56:46 INFO - Return code: 0 17:56:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:56:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:56:46 INFO - Python 2.7.3 17:56:46 INFO - Return code: 0 17:56:46 INFO - grabbing minidump binary from tooltool 17:56:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:56:46 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 0x104cacd30>, '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 0x104bd3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104ca1be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:56:46 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 17:56:46 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 17:56:46 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 17:56:46 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:56:46 INFO - Return code: 0 17:56:46 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:56:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:56:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:56:46 INFO - ENV: RUST_BACKTRACE is now 1 17:56:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:56:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:56:46 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/eUbnioplRtahrrdxjtWT1Q/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0026', '--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 17:56:46 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/eUbnioplRtahrrdxjtWT1Q/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0026 --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 17:56:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5bwEt4hO0b/Render', 17:56:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:56:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:56:46 INFO - 'HOME': '/Users/cltbld', 17:56:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:56:46 INFO - 'LOGNAME': 'cltbld', 17:56:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:56:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:56:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:56:46 INFO - 'MOZ_NO_REMOTE': '1', 17:56:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:56:46 INFO - 'NO_EM_RESTART': '1', 17:56:46 INFO - 'PAGER': '/bin/cat', 17:56:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:56:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:56:46 INFO - 'PWD': '/builds/slave/test', 17:56:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:56:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:56:46 INFO - 'RUST_BACKTRACE': '1', 17:56:46 INFO - 'SHELL': '/bin/bash', 17:56:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.I1bg8vdDKe/Listeners', 17:56:46 INFO - 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', 17:56:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:56:46 INFO - 'USER': 'cltbld', 17:56:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:56:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:56:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:56:46 INFO - 'XPC_FLAGS': '0x0', 17:56:46 INFO - 'XPC_SERVICE_NAME': '0', 17:56:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:56:46 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/eUbnioplRtahrrdxjtWT1Q/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0026', '--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 17:56:46 INFO - mozversion application_buildid: 20170314164236 17:56:46 INFO - mozversion application_changeset: cef93bf5a0a15ab7a2dc96d0cee90a599a4eae76 17:56:46 INFO - mozversion application_display_name: Nightly 17:56:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:56:46 INFO - mozversion application_name: Firefox 17:56:46 INFO - mozversion application_remotingname: firefox 17:56:46 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:56:46 INFO - mozversion application_vendor: Mozilla 17:56:46 INFO - mozversion application_version: 55.0a1 17:56:46 INFO - mozversion platform_buildid: 20170314164236 17:56:46 INFO - mozversion platform_changeset: cef93bf5a0a15ab7a2dc96d0cee90a599a4eae76 17:56:46 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:56:46 INFO - mozversion platform_version: 55.0a1 17:56:46 INFO - using testdate: 1489539406 17:56:46 INFO - actual date: 1489539406 17:56:46 INFO - starting webserver on 'localhost:49235' 17:56:46 INFO - SUITE-START | Running 2 tests 17:56:46 INFO - TEST-START | dromaeo_css 17:56:46 INFO - operating with platform_type : mac_ 17:56:46 INFO - Initialising browser for dromaeo_css test... 17:56:46 INFO - TEST-INFO | started process 1634 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/tmptDnwiM/profile http://localhost:49235/getInfo.html) 17:56:50 INFO - PID 1634 | 2017-03-14 17:56:50.028 plugin-container[1636:7730] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e3f, name = 'com.apple.tsm.portname' 17:56:50 INFO - PID 1634 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:56:50 INFO - PID 1634 | 2017-03-14 17:56:50.031 plugin-container[1636:7730] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x492b, name = 'com.apple.CFPasteboardClient' 17:56:50 INFO - PID 1634 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:56:50 INFO - PID 1634 | 2017-03-14 17:56:50.032 plugin-container[1636:7730] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 17:56:50 INFO - PID 1634 | __metrics Screen width/height:1600/1200 17:56:50 INFO - PID 1634 | colorDepth:24 17:56:50 INFO - PID 1634 | Browser inner width/height: 1024/689 17:56:50 INFO - PID 1634 | __metrics 17:56:50 ERROR - PID 1634 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3350: TypeError: this.tabs is undefined 17:56:50 INFO - TEST-INFO | 1634: exit 0 17:56:50 INFO - Browser initialized. 17:56:50 INFO - Running cycle 1/1 for dromaeo_css test... 17:56:50 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/tmptDnwiM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:56:53 INFO - PID 1637 | 2017-03-14 17:56:53.452 plugin-container[1638:7859] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x873f, name = 'com.apple.tsm.portname' 17:56:53 INFO - PID 1637 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:56:53 INFO - PID 1637 | 2017-03-14 17:56:53.453 plugin-container[1638:7859] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b0f, name = 'com.apple.CFPasteboardClient' 17:56:53 INFO - PID 1637 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:56:53 INFO - PID 1637 | 2017-03-14 17:56:53.453 plugin-container[1638:7859] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 17:57:03 INFO - PID 1637 | RSS: Main: 227500032 17:57:03 INFO - PID 1637 | 18:00:06 INFO - PID 1637 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49235/tests/dromaeo/cssquery-ext.html) 18:00:07 INFO - PID 1637 | RSS: Main: 250572800 18:00:07 INFO - PID 1637 | 18:01:51 INFO - PID 1637 | ************************* 18:01:51 INFO - PID 1637 | A coding exception was thrown and uncaught in a Task. 18:01:51 INFO - PID 1637 | 18:01:51 ERROR - PID 1637 | Full message: TypeError: NetworkError when attempting to fetch resource. 18:01:51 INFO - PID 1637 | Full stack: 18:01:51 INFO - PID 1637 | ************************* 18:03:10 INFO - PID 1637 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-ext.html (next: http://localhost:49235/tests/dromaeo/cssquery-jquery.html) 18:03:10 INFO - PID 1637 | RSS: Main: 258228224 18:03:10 INFO - PID 1637 | 18:06:12 INFO - PID 1637 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49235/tests/dromaeo/cssquery-mootools.html) 18:06:13 INFO - PID 1637 | RSS: Main: 269385728 18:06:13 INFO - PID 1637 | 18:09:15 INFO - PID 1637 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49235/tests/dromaeo/cssquery-prototype.html) 18:09:16 INFO - PID 1637 | RSS: Main: 263385088 18:09:16 INFO - PID 1637 | 18:12:18 INFO - PID 1637 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49235/tests/dromaeo/cssquery-yui.html) 18:12:19 INFO - PID 1637 | RSS: Main: 273219584 18:12:19 INFO - PID 1637 | 18:15:22 INFO - PID 1637 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-yui.html (next: http://localhost:49235/tests/dromaeo/cssquery-dojo.html) 18:15:22 INFO - PID 1637 | RSS: Main: 267309056 18:15:22 INFO - PID 1637 | 18:15:22 INFO - PID 1637 | __start_tp_report 18:15:22 INFO - PID 1637 | _x_x_mozilla_page_load 18:15:22 INFO - PID 1637 | _x_x_mozilla_page_load_details 18:15:22 INFO - PID 1637 | |i|pagename|runs| 18:15:22 INFO - PID 1637 | |0;dojo.html;2993.655729591096;3033.742131918787;3137.5607414961896;3387.661233876614;3479.112826229311;4132.917341653173;4609.769511524423;5247.947520524794;6006.279246490421;6037.728302226399;5884.382139875315;5888.381719919411;5895.764169433228;5922.822315330547;5937.703114844251;4382.605565499104;5477.123660214366;5483.451654834525;5517.972410137943;5572.637778544402;5461.290032295796;5521.944780552203;5526.696031718274;5536.446355364472;5540.141278101901;4485.215087359716;5357.249985002103;5438.782448702067;5527.640703354289;5541.972290138564;5356;5396.946030539683;5432.049391356497;5445.401005889349;5478.698671573062;5386.245925570423;5389.8113566025395;5393.002294575477;5403.972980135113;5426.131818908995;5877.9118313225335;6031.487323577501;6036.0945858121195;6052.848678783022;6082.635041897501;6285.245770507523;6335.588186767845;6344.080108384304;6406.1351717518;6408;5413.675179489204;6436.806895793134;6446.194225721785;6453.548251622388;6468.3855033771715;5016.949830501721;6168.167297414837;6182.598131121463;6186.536009799193;6187.288461826947;6330.588511746721;6401.8719625608155;6471.935280647133;6519.119918810995;6598.538102332886;6213.00591905293;6324.367563243639;6336.366363363627;6341.651209183447;6342.714577844008;6282.842928926813;6335.334789847;6338.968305158444;6392.552521323556;6402.743890244431;6297.716602752887;6371.076193951851;6376.872462550723;6390.584612000205;6391.328910464427;6140.4473597376455;6365.713542890581;6376.585521941059;6378.681065946684;6382.489400847921;5124.718140502234;5149.0474262261605;5180.766865491062;5181.1969144782615;5181.896362072737;4643.257078867433;4662.067586482717;4678.906421871544;4679.087577922272;4724.173269677793;6145.631262124287;6181.258249010148;6191.628502289877;6195.380461953859;6214.937850621436;6321.273053598895;6338.651374174465;6484.319146489551;6486.124373209651;6515.283318834924;6131.132004888217;6160;6194.26560563043;6199.380061993855;6223.315435302113;5577.96807590597;5664.150377443334;5765.04876695349;5779.8555036124435;5801.01382764931;5537.5569954404355;6052.455279024909;6403.327650596713;6443.548951573345;6671.766488172891;6337.7781777637565;6423.229212494531;6464.256610489854;6471.7734879279;6515.576487528296;6702.430293425114;6705.497087718538;6711.127553418024;6718.731250750111;6726.932730672631;6308.243010838729;6359.3640635936035;6399.968000159969;6402.903956440564;6412.294647588855;6127.769884593299;6326.43062124411;6415.069814876723;6420.5826621271335;6481.967590162019;6263.217097862767;6302.936970630235;6321;6323.241211054703;6323.304436512072;5940.287165540163;6192.659403732838;6232.002879539252;6290.937090629035;6314.778982735582;4871.780769865293;6154.969225153845;6259.029850373199;6283.465905397909;6291.779787707408;6280.591761535668;6317.020861766434;6318.62088274705;6320.905186422116;6334.113224148531;6301;6301;6304.148939893055;6324.3991820776955;6332.936670633235 18:15:22 INFO - PID 1637 | |1;ext.html;724.4132252875172;774.399840123904;801.8837268596054;929.5398777605086;935.8409070458026;37454;38040.61959380409;38058.619413805885;38074.42888356677;38097.619023809755;36822.44766328507;36990.4451433228;37146.257074858484;37253;37482.875513734565;7690.923090769076;7849.882251766228;10585.629502967398;10859.565617375296;10875.945620271888;10857.728556786104;10955.17836162287;11011.61459348923;11012.614558490455;11019.008289253965;10934.617288394908;11023.007929286403;11027.558897644085;11033.337999720043;11060.446977651085;10971.945140274287;10979.83530247047;11012.559497620086;11029.889701102966;11035.99999999992;10799.946000269949;10887.618933337295;10891.67324980244;10892.237543371966;10897.346159230392;37920.672776452695;38139;38176.04559885997;38222;38329.616703832886;3771.302309072803;3792.126483466411;3810;3816.351220292529;3959.0300376407963;23902;27866.58200127;28621.28446788826;28636.856815715997;28749.56875646867;2900.6664233612983;3132.3108916038436;3159.526071089332;3242.2866969266724;3242.5622540956906;257653;263646.6817665899;265134.6973060547;353965;367652;45831;46098;46113.76943115263;46125.7693711536;46173.53826461759;48400;50449;50671.493285067416;50687;51173.720656983875;14407.207603581903;14535.27323633814;14554.199519026555;14580.927095364455;14699.41202351894;9954.601815927426;11661;11796.410179491162;11806.996405305645;11840.28958262507;13666.93166534161;13677.24775137377;13683.179009259477;13738.900887928941;13811.792823107662;4739.597134243559;5063.797448102035;6021.548383871227;6052.576319657582;6097.603655762361;809.668036105194;922.8108237811233;924.4961495984704;962.1100482054072;976.3751199232497;22571.43571410728;26375.86812065966;27363.589546156825;27681.446371072467;28063.57904631432;1012.2812802910016;1015.1523477896039;1043.5721354244874;1045.1899777672365;1056.7727938493108;12804.679883002813;14232.359543820552;14465.710685786436;14558.563243102511;14560.927195363955;360143.19928400713;366437;367665;367913.369096241;411244;46006;56545.7172714142;57349.71325143347;57353.713231433576;57397.426025740046;1211.4487908001838;1221.3343727668441;1381.3162484570203;1410.9082909611047;1432.298173894805;25861.70691465457;27038.78325475319;27736.72263277422;27932.720672793013;27950.30124246829;48032.759836200596;48429.75785121052;48454;48722;48765;404611.9769401134;479654;481007;482142.5892870513;483165;32695;33178.834105829315;33357.99926002224;33387;33462;36535;40321;40479.59520404758;40659.390109148975;41163.588364117175;32327.67609759969;32718.83640581782;33783.662163379035;34477.48283775695;34791.47812782861;23132;32493;33207.667923320456;33405.33189336151;35777;34611.82694086513;35273.823630881685;35618.46572301366;35891.64108358987;35953.28093438169;29842.403151937273;31146.68853311438;31279.84360078185;31291.53062704107;31327.530087048257;19167.52081197981;19756;21240.362789116352;21358.78641213568;24154.396140096636 18:15:22 INFO - PID 1637 | |2;jquery.html;364.41875209041575;395.81594558530315;410.3332085361286;411.0914878119357;428.4922366995111;20778.376648700545;21533.569328613437;21606;21613.567728645437;22772.65841012382;16274.918625406857;16629.91685041573;17313.96116233027;22880.65679014816;22900.541989160247;5695.430456954313;5769.653820770767;6249.875002499959;6603.3396660334065;6613.933860661404;6304.936950630481;6506.056621789838;6519.217693876742;6590.835229119262;6615.5369124161325;6571.112899758519;6589.736410543596;6589.967050164766;6609.6695165241545;6622.470202383798;6345.619262844244;6568.080468734357;6576.0135979602965;6621.536492445531;6640.535162538624;6176.4749996250375;6441.806745797634;6446.677666116675;6468.547201695883;6493.383128602775;21265.36203913885;26844.46311073787;27510;27823.86088069567;27898;3337.332533493287;3338.549295845054;3364.882229121969;3370.865165393381;3536.3811333016874;15044.849551504454;15655.608609784733;15782.763258551131;15854.207289635473;16587;1947.221111555375;1994.5140870051905;2005.46855083403;2013.2047841102828;2033.196887229536;158114;161144;162206.37793622032;162862;166248;22330;22589.77410225877;22663.433414164778;22856.857157142076;22993;26473.86763066211;37069;37210.883673489836;37309;37391.252174956346;10373.533191006423;10565.471726413802;10646.148308135485;10749.19381046409;10866.891331086747;6930.7227710891;8394;8402.28580570646;8408.915910840813;8575.099614540508;10619.469026548642;10707.875673054374;10752.731181720519;10798.460076996276;10869.021788039114;3774.5659249186147;3810.7713537187856;4437.179121862466;4462.41988541494;4487.439070116236;970.2529052629436;986.7829077602916;988.8640982702315;1003.5132960514145;1041.770810421721;18610.976396298334;19150.233990640496;21611.459713507287;23122.65316020261;23316.300510984696;880.4937161132375;995.4873240281261;1021.8927012663712;1051.9053285204368;1083.247143235444;11956.282623042645;12254.571090011807;12341.75316493665;12410.75178496443;12410.937945310396;670721.6463917746;671614;687654.5617271882;702280;720628;117924;122084.77915220734;142136;159982;160867;1206.1677442564603;1260.3824126178106;1303.9413226404833;1309.5678426119548;1310.744404841066;21505.56988860183;21655.891720541298;21817.781822181576;21926.780732192474;22001.449963750394;57698;57847.132293014794;57976;58299;58967.70516147392;49338.75330623324;80560.79158812505;83237;83807.5809620948;85972.14027859642;11384.544618215179;11704.239224450725;11796.94101529487;12060.879391206327;12245.755084898074;9893.802123957625;13142.039014496228;13645.727085458037;13651.11267767592;13780.931095344458;9876.703698889045;10917.344959302467;11387;11532.019778318936;11784.057275418118;11250.212485125963;11275.32348059119;11356.318620882774;11480.196386253216;11683;11741.29552226869;11788.29270243788;11970.401479926142;12063.276203427822;12081.214721043105;9118.726438206864;10135.682361292984;12033.278003319829;12042;12196.817047744113;11498.48256828428;11541.192116551762;11761.235519691192;11809;11916.582919597773 18:15:22 INFO - PID 1637 | |3;mootools.html;1499.542639494955;1522.3453914816632;1538.3615799443232;1559.485369827957;1561.7032763774885;10516.631917882876;10743.19426043046;10961.671149865508;10987.011168994788;11106.555737770479;10652.573897044129;10852.403117828537;10858.402787846666;10884.891151088486;10936.507857146447;2310.1683393978155;2350.576896158691;2352.176738141654;2354.8587084774967;2358.8584684918874;1965.4005528313858;2268.6483595042714;2305.7809508096702;2305.988470057656;2308.6883270758485;2280.5780930527903;2283.942901427469;2292.6904867842795;2301.3671240408853;2309.515001849614;2246.29241788836;2254.966175507369;2266.739324977624;2268.4215525041172;2277.350954977832;2271;2340.8127349811975;2343.379004563792;2345.8475199112004;2345.906163753448;11084.390358530278;11107.111431085494;11108;11174.776504469864;11194.832077518762;5317.46825317469;5477.3427188737205;5504.64219825714;5514.5864060195245;5554;3145.7955232910017;3364.1253274148653;3367;3451.620321764604;3508.947365789515;1157.2882677153575;1168.760404117154;1191.606769765975;1201.0331682995186;1237.0227520258984;15008.624784380369;15045.548633541011;15087.24563771807;15165.696686066216;15205.239738013166;4328.632066274339;4555.339475775994;4584.862454126382;4679.532046795293;4697.365855609449;11296.54813807455;11335.829962550568;11368.317900925971;11368.715782105348;11389.259698119597;5424.755885985141;5460.426655201226;5507.669539827623;5527.613067085346;5531.446855314517;4934.013197360542;4977.950220497749;5001.699898006059;5054.9241761373605;5140.485951404829;3698.8890333290046;3700.1859590889962;3801.486799282117;3821.828017739153;3877.2245550889934;1024.933379330341;1035.6219979707503;1037.2324479884983;1051.5057922776282;1052.85786418834;767.2864236260332;811.7970507373157;888.493558671564;905.4250550900226;938.8075444533854;5237.371515418098;5697.7464957709235;6342.492600592034;6612.471002319803;6899.724011039602;818.5743413424985;1025.2361990317113;1035.4201647077662;1046.5865982936698;1053.578568572577;4185.079282557833;4189.889679235005;4203.43253660758;4326.956730432718;4360.978195109004;13524.93237533806;13546.864531354757;13985.86014139866;14011.649708757363;14047.578572642837;11858.169928105122;12252.264864108181;13397.928165746716;13980.930095349662;13990.790138147935;7743.341815945595;8270.462419942685;8510.276626486695;9998.750031249132;10067.597296108073;6616.702248398929;6647.800565983028;6649.235337936006;6748.223954245324;6756.391924726799;11423.714407139889;12288.447019883948;12310.630681079581;12366.62900112998;12447.502099915902;12341.444634991267;12346.13577049598;12460.314682692539;12728.299943503196;12823.03827212944;8242.340612750846;8419.83160336802;8432.704855330034;8491.617877195418;8516.190961858614;8824.426412283181;9121.133492318218;9283.11810378013;10121.342112762646;10253.33353332031;8061.758147255592;8190.058143313595;8195.71315003972;8208.425410221227;8292.502449853027;8201.30288925424;8630.78423039404;8684.305255579413;8761.386702930733;8829.558522074;6668.599594085296;7475.36459400957;7669.156392796676;7684.961575192088;7816;4625.7918393673035;5742.454466825645;5876.08920617305;5887.1757953885635;5949.07789292643;5210.557102646318;5824.213731146241;6006.189164462741;6077.2099627049965;6102.956912984828 18:15:22 INFO - PID 1637 | |4;prototype.html;374.36171327885955;387.85455454204674;389.9805009749512;393.31759397445427;399.93001224785667;5102.668326558771;6094.207752992105;6257.249130104383;6271.686415679215;6385.648789316591;5039.395272567297;5803.245578074855;6127.724252408641;6134.754609815602;6137.508999280058;4060.979695101528;5007.699538027712;5019.824306149286;5029.1199040168;5052.671576347544;4698.624110071203;4878.024598331343;4945.455999840015;4958.082754690394;5003.824866129687;4048.6356227939477;4957.925631115536;4962.337616898343;4987.351644286237;5011.824586139486;4059.6143366380147;4979.751012449363;5006.22403527452;5006.924896126561;5011.273365362002;4418.513963464016;4508.977455112704;4555.567221113989;4563.680542362036;4580.290055041474;4803.663743537953;4808.903821923577;5391.622586418952;5940.405959404068;5960.344362120163;5339.279197308352;5420.83737487876;5435.701036442994;5821.330546987108;5828.115083033926;6506.707198176094;6513.967430162867;6530.734632683658;6565.704543295516;6573.835654108638;4180.26845302074;4778.685861388111;5088;5111.1566591512355;5120.897582048376;5952.285725712899;6113.449789518964;6153.907691384633;6887.483438742064;6935.202451718016;4424.491183513937;5305.991861546294;5358.624896257303;5366.409694933554;5385.8114965976;4399.680095971195;5397.8110766123;5427.565794736412;5438.700871452029;5455.781768729206;5588.842304098172;5701.686407247641;5822.272215973004;5836.986239747281;5845.240118784531;6460.481786780103;6519.4132528072705;6532.804015879531;6559.882527457762;6567.2447668518735;1477.0842077911764;1762.2598508626409;1813.7642106526066;1821.1986725840588;1830;1143.7540928700369;1182.2197349749124;1312.9146605470614;1356.647271709343;1367.3778430813957;5234.319538459976;5371.459379586398;6032.306284777307;6128.17269668598;6179.474744646755;6774.983752437075;6807.285235050347;6831.882116543888;6839.829004274833;6853.725850966005;5545.390007099216;5927.940720592739;6059.515238780975;6147.569670123048;6200.410960958701;3167.7624178186265;3573.213892943548;3577.01632051188;3582.140286331262;3587.9282414351565;5697.6296540724725;6774.525783195129;6931.861362772817;7019.684114214872;7045.534063077984;6826.4538836892925;6841;6915.204751453647;6958.617276049765;6979.546329488567;5920.963831329586;6268.432891777055;7019.192792828788;7029.89455158173;7069.540479868792;5313.4304498130805;6562.868742625216;6835.521513494008;6848.863022739617;6894.482913781587;6133.202683651097;6368.363163683594;6689.09697190873;6705.0612914193025;6750.561213521106;6035.728392222272;6842.692078856563;7017.298270172942;7053.365197132282;7082.681279342545;3939.1727737175515;4405.735655860659;4461.977690111528;5058;5126.538611524831;5643.971780141237;6210.689465526796;6278.340774218641;6742.325767423218;6871.347222013901;6597.668177570296;6610.636414997221;6619.470442364695;6655.534112612264;6678.198616166092;5793.725380416302;6004.519638428827;6557.491741918051;6582.275949645631;6617.371349721769;5581.609287349846;5885.94114058871;6094.39056094387;6423.839404014937;6457.128287681103;4936.457724272074;6503.187101612299;6545.498158485188;6572.211334639874;6630.900536492053;6433.906235939808;6474.924410904782;6491.383318584727;6497.62836564641;6506.544541882023 18:15:22 INFO - PID 1637 | |5;yui.html;689.4656641103145;690.4717890813529;699.8950157476381;712.2130046298839;772.4361216312092;14927.850721492781;15250.313735881884;15447.768283475743;15468;15517.146556939364;12011.219270747395;13648.38582263798;14542.345594448248;14547.418103275857;15082.849171508282;846.8010017645848;920.2132176988662;950.2018304624114;956.3114557518576;957.7270477913796;897.757605446529;940.2008292951006;953.3040880157489;960.5581432541039;961.1829944547148;992.4343124419084;997.975050623733;1005.3565717940523;1006.9093781559658;1011.1304278320638;995.8804943406801;1001.4692213127017;1002.7292630989665;1004.7287232447198;1007.1791489935679;742.3986570877606;746.4438992950287;747.8504299140194;747.9102507699057;748.1060133140899;15893.761593576106;16079.517614471584;16504.66990660192;16616.6676666466;16859.40992065284;14355.425782968668;14616;14693.706125877423;14739.263036848115;14780.704385912222;10127.949360253226;11327.660170194826;11691.649250522498;11967.1622986391;12186.939065304705;3699.5560532735976;3879.72841901067;3887.4168874668744;3893.1045859452483;3899.629535194152;108410.45794771054;110000;110558;113000.86999129986;113619.43190284078;9563.856542151872;10697.99281470638;11185.552577896955;11568.074554035826;11677.88322116768;24354.75645243525;24521.754782452303;24899.004039838204;24925.626115607916;25006.999720010997;7697.499662521918;7815.3356964657505;7834.804129896685;7924.801879953047;8061.355091592659;3937.468441760383;4181.414601955728;4259.467566554181;4269.61573458384;4272.700910936204;3159.526071089355;3533.7349698772696;3557.4308110702164;3559.555055618048;3563.1448452371246;635.5397385575573;642.9710663020176;644.9806505804834;646.6314200905439;651.0689713709346;654.2443477783168;654.991313377403;664.8204984654117;674.1438373265925;674.4671709349657;9582.210844359839;10036.567878814833;10070.560603497202;10409.167266618653;10431.94784026075;684.7397988764337;686.8111269400855;697.8953157026486;702.5468572770534;711.1750369571273;3824;4548.295014272793;4908.730019848871;4911.45973942866;4940.827071052496;77302;81425;87332.12667873366;95016;100352.4982375098;71072;71789.20526986763;74099.62950185215;75072;76224.61887690525;64880.67559662172;67806;71526;78863.21136788558;80513.98715032054;9417.340786145178;10497.790044199226;10977.231593788358;10995.835062473909;11190.32858028521;42231.366529501465;46082;49739.253911192085;49983.50049498521;50824.98350032905;60126;61899;62143;63508;65877.35306617373;13158.671033224246;13351;13462.903532187456;13606.047576669538;13967.371468283749;14459.855401445851;14466.638334041732;14522.20127892976;14627.488037918622;14661.63345916318;13791.931040344734;13856.099353541988;13931.721365572834;14098.929505352407;14251.025038812199;10565.366078035342;12469.314187719763;12682.112252142262;12727.74544509086;13091.214527128403;10764.246502744732;13516.25611842886;13643.86356136426;13724.862751372359;13783.586492405244;10229.948850255701;10892.564297428014;11036.172287078662;11093.16801239894;11402.486888090221;9229.169374756304;10159.339642923187;10325.277230593787;11501.194916355775;11758.823617645914 18:15:22 INFO - PID 1637 | __end_tp_report 18:15:22 INFO - PID 1637 | __start_cc_report 18:15:22 INFO - PID 1637 | _x_x_mozilla_cycle_collect,437 18:15:22 INFO - PID 1637 | __end_cc_report 18:15:22 INFO - PID 1637 | __startTimestamp1489540522934__endTimestamp 18:15:22 INFO - PID 1637 | 18:15:22 INFO - PID 1637 | ------- Summary: start ------- 18:15:22 INFO - PID 1637 | Number of tests: 6 18:15:22 INFO - PID 1637 | 18:15:22 INFO - PID 1637 | [#0] dojo.html Cycles:165 Average:5914.03 Median:6213.01 stddev:721.48 (11.6%) stddev-sans-first:686.35 18:15:22 INFO - PID 1637 | Values: 2993.7 3033.7 3137.6 3387.7 3479.1 4132.9 4609.8 5247.9 6006.3 6037.7 5884.4 5888.4 5895.8 5922.8 5937.7 4382.6 5477.1 5483.5 5518.0 5572.6 5461.3 5521.9 5526.7 5536.4 5540.1 4485.2 5357.2 5438.8 5527.6 5542.0 5356.0 5396.9 5432.0 5445.4 5478.7 5386.2 5389.8 5393.0 5404.0 5426.1 5877.9 6031.5 6036.1 6052.8 6082.6 6285.2 6335.6 6344.1 6406.1 6408.0 5413.7 6436.8 6446.2 6453.5 6468.4 5016.9 6168.2 6182.6 6186.5 6187.3 6330.6 6401.9 6471.9 6519.1 6598.5 6213.0 6324.4 6336.4 6341.7 6342.7 6282.8 6335.3 6339.0 6392.6 6402.7 6297.7 6371.1 6376.9 6390.6 6391.3 6140.4 6365.7 6376.6 6378.7 6382.5 5124.7 5149.0 5180.8 5181.2 5181.9 4643.3 4662.1 4678.9 4679.1 4724.2 6145.6 6181.3 6191.6 6195.4 6214.9 6321.3 6338.7 6484.3 6486.1 6515.3 6131.1 6160.0 6194.3 6199.4 6223.3 5578.0 5664.2 5765.0 5779.9 5801.0 5537.6 6052.5 6403.3 6443.5 6671.8 6337.8 6423.2 6464.3 6471.8 6515.6 6702.4 6705.5 6711.1 6718.7 6726.9 6308.2 6359.4 6400.0 6402.9 6412.3 6127.8 6326.4 6415.1 6420.6 6482.0 6263.2 6302.9 6321.0 6323.2 6323.3 5940.3 6192.7 6232.0 6290.9 6314.8 4871.8 6155.0 6259.0 6283.5 6291.8 6280.6 6317.0 6318.6 6320.9 6334.1 6301.0 6301.0 6304.1 6324.4 6332.9 18:15:22 INFO - PID 1637 | 18:15:22 INFO - PID 1637 | [#1] ext.html Cycles:180 Average:52401.49 Median:33193.25 stddev:102866.26 (309.9%) stddev-sans-first:103081.66 18:15:22 INFO - PID 1637 | Values: 724.4 774.4 801.9 929.5 935.8 37454.0 38040.6 38058.6 38074.4 38097.6 36822.4 36990.4 37146.3 37253.0 37482.9 7690.9 7849.9 10585.6 10859.6 10875.9 10857.7 10955.2 11011.6 11012.6 11019.0 10934.6 11023.0 11027.6 11033.3 11060.4 10971.9 10979.8 11012.6 11029.9 11036.0 10799.9 10887.6 10891.7 10892.2 10897.3 37920.7 38139.0 38176.0 38222.0 38329.6 3771.3 3792.1 3810.0 3816.4 3959.0 23902.0 27866.6 28621.3 28636.9 28749.6 2900.7 3132.3 3159.5 3242.3 3242.6 257653.0 263646.7 265134.7 353965.0 367652.0 45831.0 46098.0 46113.8 46125.8 46173.5 48400.0 50449.0 50671.5 50687.0 51173.7 14407.2 14535.3 14554.2 14580.9 14699.4 9954.6 11661.0 11796.4 11807.0 11840.3 13666.9 13677.2 13683.2 13738.9 13811.8 4739.6 5063.8 6021.5 6052.6 6097.6 809.7 922.8 924.5 962.1 976.4 22571.4 26375.9 27363.6 27681.4 28063.6 1012.3 1015.2 1043.6 1045.2 1056.8 12804.7 14232.4 14465.7 14558.6 14560.9 360143.2 366437.0 367665.0 367913.4 411244.0 46006.0 56545.7 57349.7 57353.7 57397.4 1211.4 1221.3 1381.3 1410.9 1432.3 25861.7 27038.8 27736.7 27932.7 27950.3 48032.8 48429.8 48454.0 48722.0 48765.0 404612.0 479654.0 481007.0 482142.6 483165.0 32695.0 33178.8 33358.0 33387.0 33462.0 36535.0 40321.0 40479.6 40659.4 41163.6 32327.7 32718.8 33783.7 34477.5 34791.5 23132.0 32493.0 33207.7 33405.3 35777.0 34611.8 35273.8 35618.5 35891.6 35953.3 29842.4 31146.7 31279.8 31291.5 31327.5 19167.5 19756.0 21240.4 21358.8 24154.4 18:15:22 INFO - PID 1637 | 18:15:22 INFO - PID 1637 | [#2] jquery.html Cycles:180 Average:41136.09 Median:21872.28 stddev:115587.42 (528.5%) stddev-sans-first:115871.13 18:15:22 INFO - PID 1637 | Values: 364.4 395.8 410.3 411.1 428.5 20778.4 21533.6 21606.0 21613.6 22772.7 16274.9 16629.9 17314.0 22880.7 22900.5 5695.4 5769.7 6249.9 6603.3 6613.9 6304.9 6506.1 6519.2 6590.8 6615.5 6571.1 6589.7 6590.0 6609.7 6622.5 6345.6 6568.1 6576.0 6621.5 6640.5 6176.5 6441.8 6446.7 6468.5 6493.4 21265.4 26844.5 27510.0 27823.9 27898.0 3337.3 3338.5 3364.9 3370.9 3536.4 15044.8 15655.6 15782.8 15854.2 16587.0 1947.2 1994.5 2005.5 2013.2 2033.2 158114.0 161144.0 162206.4 162862.0 166248.0 22330.0 22589.8 22663.4 22856.9 22993.0 26473.9 37069.0 37210.9 37309.0 37391.3 10373.5 10565.5 10646.1 10749.2 10866.9 6930.7 8394.0 8402.3 8408.9 8575.1 10619.5 10707.9 10752.7 10798.5 10869.0 3774.6 3810.8 4437.2 4462.4 4487.4 970.3 986.8 988.9 1003.5 1041.8 18611.0 19150.2 21611.5 23122.7 23316.3 880.5 995.5 1021.9 1051.9 1083.2 11956.3 12254.6 12341.8 12410.8 12410.9 670721.6 671614.0 687654.6 702280.0 720628.0 117924.0 122084.8 142136.0 159982.0 160867.0 1206.2 1260.4 1303.9 1309.6 1310.7 21505.6 21655.9 21817.8 21926.8 22001.4 57698.0 57847.1 57976.0 58299.0 58967.7 49338.8 80560.8 83237.0 83807.6 85972.1 11384.5 11704.2 11796.9 12060.9 12245.8 9893.8 13142.0 13645.7 13651.1 13780.9 9876.7 10917.3 11387.0 11532.0 11784.1 11250.2 11275.3 11356.3 11480.2 11683.0 11741.3 11788.3 11970.4 12063.3 12081.2 9118.7 10135.7 12033.3 12042.0 12196.8 11498.5 11541.2 11761.2 11809.0 11916.6 18:15:22 INFO - PID 1637 | 18:15:22 INFO - PID 1637 | [#3] mootools.html Cycles:180 Average:6538.71 Median:2356.86 stddev:4153.74 (176.2%) stddev-sans-first:4148.14 18:15:22 INFO - PID 1637 | Values: 1499.5 1522.3 1538.4 1559.5 1561.7 10516.6 10743.2 10961.7 10987.0 11106.6 10652.6 10852.4 10858.4 10884.9 10936.5 2310.2 2350.6 2352.2 2354.9 2358.9 1965.4 2268.6 2305.8 2306.0 2308.7 2280.6 2283.9 2292.7 2301.4 2309.5 2246.3 2255.0 2266.7 2268.4 2277.4 2271.0 2340.8 2343.4 2345.8 2345.9 11084.4 11107.1 11108.0 11174.8 11194.8 5317.5 5477.3 5504.6 5514.6 5554.0 3145.8 3364.1 3367.0 3451.6 3508.9 1157.3 1168.8 1191.6 1201.0 1237.0 15008.6 15045.5 15087.2 15165.7 15205.2 4328.6 4555.3 4584.9 4679.5 4697.4 11296.5 11335.8 11368.3 11368.7 11389.3 5424.8 5460.4 5507.7 5527.6 5531.4 4934.0 4978.0 5001.7 5054.9 5140.5 3698.9 3700.2 3801.5 3821.8 3877.2 1024.9 1035.6 1037.2 1051.5 1052.9 767.3 811.8 888.5 905.4 938.8 5237.4 5697.7 6342.5 6612.5 6899.7 818.6 1025.2 1035.4 1046.6 1053.6 4185.1 4189.9 4203.4 4327.0 4361.0 13524.9 13546.9 13985.9 14011.6 14047.6 11858.2 12252.3 13397.9 13980.9 13990.8 7743.3 8270.5 8510.3 9998.8 10067.6 6616.7 6647.8 6649.2 6748.2 6756.4 11423.7 12288.4 12310.6 12366.6 12447.5 12341.4 12346.1 12460.3 12728.3 12823.0 8242.3 8419.8 8432.7 8491.6 8516.2 8824.4 9121.1 9283.1 10121.3 10253.3 8061.8 8190.1 8195.7 8208.4 8292.5 8201.3 8630.8 8684.3 8761.4 8829.6 6668.6 7475.4 7669.2 7685.0 7816.0 4625.8 5742.5 5876.1 5887.2 5949.1 5210.6 5824.2 6006.2 6077.2 6103.0 18:15:22 INFO - PID 1637 | 18:15:22 INFO - PID 1637 | [#4] prototype.html Cycles:180 Average:5428.79 Median:5903.45 stddev:1574.48 (26.7%) stddev-sans-first:1532.51 18:15:22 INFO - PID 1637 | Values: 374.4 387.9 390.0 393.3 399.9 5102.7 6094.2 6257.2 6271.7 6385.6 5039.4 5803.2 6127.7 6134.8 6137.5 4061.0 5007.7 5019.8 5029.1 5052.7 4698.6 4878.0 4945.5 4958.1 5003.8 4048.6 4957.9 4962.3 4987.4 5011.8 4059.6 4979.8 5006.2 5006.9 5011.3 4418.5 4509.0 4555.6 4563.7 4580.3 4803.7 4808.9 5391.6 5940.4 5960.3 5339.3 5420.8 5435.7 5821.3 5828.1 6506.7 6514.0 6530.7 6565.7 6573.8 4180.3 4778.7 5088.0 5111.2 5120.9 5952.3 6113.4 6153.9 6887.5 6935.2 4424.5 5306.0 5358.6 5366.4 5385.8 4399.7 5397.8 5427.6 5438.7 5455.8 5588.8 5701.7 5822.3 5837.0 5845.2 6460.5 6519.4 6532.8 6559.9 6567.2 1477.1 1762.3 1813.8 1821.2 1830.0 1143.8 1182.2 1312.9 1356.6 1367.4 5234.3 5371.5 6032.3 6128.2 6179.5 6775.0 6807.3 6831.9 6839.8 6853.7 5545.4 5927.9 6059.5 6147.6 6200.4 3167.8 3573.2 3577.0 3582.1 3587.9 5697.6 6774.5 6931.9 7019.7 7045.5 6826.5 6841.0 6915.2 6958.6 6979.5 5921.0 6268.4 7019.2 7029.9 7069.5 5313.4 6562.9 6835.5 6848.9 6894.5 6133.2 6368.4 6689.1 6705.1 6750.6 6035.7 6842.7 7017.3 7053.4 7082.7 3939.2 4405.7 4462.0 5058.0 5126.5 5644.0 6210.7 6278.3 6742.3 6871.3 6597.7 6610.6 6619.5 6655.5 6678.2 5793.7 6004.5 6557.5 6582.3 6617.4 5581.6 5885.9 6094.4 6423.8 6457.1 4936.5 6503.2 6545.5 6572.2 6630.9 6433.9 6474.9 6491.4 6497.6 6506.5 18:15:22 INFO - PID 1637 | 18:15:22 INFO - PID 1637 | [#5] yui.html Cycles:180 Average:19576.10 Median:3545.58 stddev:27298.56 (769.9%) stddev-sans-first:27338.30 18:15:22 INFO - PID 1637 | Values: 689.5 690.5 699.9 712.2 772.4 14927.9 15250.3 15447.8 15468.0 15517.1 12011.2 13648.4 14542.3 14547.4 15082.8 846.8 920.2 950.2 956.3 957.7 897.8 940.2 953.3 960.6 961.2 992.4 998.0 1005.4 1006.9 1011.1 995.9 1001.5 1002.7 1004.7 1007.2 742.4 746.4 747.9 747.9 748.1 15893.8 16079.5 16504.7 16616.7 16859.4 14355.4 14616.0 14693.7 14739.3 14780.7 10127.9 11327.7 11691.6 11967.2 12186.9 3699.6 3879.7 3887.4 3893.1 3899.6 108410.5 110000.0 110558.0 113000.9 113619.4 9563.9 10698.0 11185.6 11568.1 11677.9 24354.8 24521.8 24899.0 24925.6 25007.0 7697.5 7815.3 7834.8 7924.8 8061.4 3937.5 4181.4 4259.5 4269.6 4272.7 3159.5 3533.7 3557.4 3559.6 3563.1 635.5 643.0 645.0 646.6 651.1 654.2 655.0 664.8 674.1 674.5 9582.2 10036.6 10070.6 10409.2 10431.9 684.7 686.8 697.9 702.5 711.2 3824.0 4548.3 4908.7 4911.5 4940.8 77302.0 81425.0 87332.1 95016.0 100352.5 71072.0 71789.2 74099.6 75072.0 76224.6 64880.7 67806.0 71526.0 78863.2 80514.0 9417.3 10497.8 10977.2 10995.8 11190.3 42231.4 46082.0 49739.3 49983.5 50825.0 60126.0 61899.0 62143.0 63508.0 65877.4 13158.7 13351.0 13462.9 13606.0 13967.4 14459.9 14466.6 14522.2 14627.5 14661.6 13791.9 13856.1 13931.7 14098.9 14251.0 10565.4 12469.3 12682.1 12727.7 13091.2 10764.2 13516.3 13643.9 13724.9 13783.6 10229.9 10892.6 11036.2 11093.2 11402.5 9229.2 10159.3 10325.3 11501.2 11758.8 18:15:22 INFO - PID 1637 | -------- Summary: end -------- 18:15:22 INFO - PID 1637 | 18:15:23 INFO - TEST-INFO | 1637: exit 0 18:15:23 INFO - TEST-OK | dromaeo_css | took 1116763ms 18:15:23 INFO - TEST-START | kraken 18:15:23 INFO - operating with platform_type : mac_ 18:15:23 INFO - Initialising browser for kraken test... 18:15:23 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/tmpCcPYZM/profile http://localhost:49235/getInfo.html) 18:15:26 INFO - PID 1649 | 2017-03-14 18:15:26.488 plugin-container[1650:10444] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d47, name = 'com.apple.tsm.portname' 18:15:26 INFO - PID 1649 | See /usr/include/servers/bootstrap_defs.h for the error codes. 18:15:26 INFO - PID 1649 | 2017-03-14 18:15:26.492 plugin-container[1650:10444] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x910f, name = 'com.apple.CFPasteboardClient' 18:15:26 INFO - PID 1649 | See /usr/include/servers/bootstrap_defs.h for the error codes. 18:15:26 INFO - PID 1649 | 2017-03-14 18:15:26.492 plugin-container[1650:10444] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 18:15:26 INFO - PID 1649 | __metrics Screen width/height:1600/1200 18:15:26 INFO - PID 1649 | colorDepth:24 18:15:26 INFO - PID 1649 | Browser inner width/height: 1024/689 18:15:26 INFO - PID 1649 | __metrics 18:15:26 ERROR - PID 1649 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3350: TypeError: this.tabs is undefined 18:15:27 INFO - TEST-INFO | 1649: exit 0 18:15:27 INFO - Browser initialized. 18:15:27 INFO - Running cycle 1/1 for kraken test... 18:15:27 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/tmpCcPYZM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:15:29 INFO - PID 1651 | 2017-03-14 18:15:29.797 plugin-container[1652:10566] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x883f, name = 'com.apple.tsm.portname' 18:15:29 INFO - PID 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 18:15:29 INFO - PID 1651 | 2017-03-14 18:15:29.797 plugin-container[1652:10566] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d0b, name = 'com.apple.CFPasteboardClient' 18:15:29 INFO - PID 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 18:15:29 INFO - PID 1651 | 2017-03-14 18:15:29.798 plugin-container[1652:10566] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 18:15:39 INFO - PID 1651 | RSS: Main: 228392960 18:15:39 INFO - PID 1651 | 18:15:42 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-beat-detection) 18:15:43 INFO - PID 1651 | RSS: Main: 241508352 18:15:43 INFO - PID 1651 | 18:15:45 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-dft) 18:15:46 INFO - PID 1651 | RSS: Main: 250232832 18:15:46 INFO - PID 1651 | 18:15:49 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-fft) 18:15:50 INFO - PID 1651 | RSS: Main: 252416000 18:15:50 INFO - PID 1651 | 18:15:52 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-oscillator) 18:15:53 INFO - PID 1651 | RSS: Main: 255127552 18:15:53 INFO - PID 1651 | 18:15:55 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:15:55 INFO - PID 1651 | RSS: Main: 255610880 18:15:55 INFO - PID 1651 | 18:15:58 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-darkroom) 18:15:59 INFO - PID 1651 | RSS: Main: 261562368 18:15:59 INFO - PID 1651 | 18:16:02 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-desaturate) 18:16:03 INFO - PID 1651 | RSS: Main: 261931008 18:16:03 INFO - PID 1651 | 18:16:06 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49235/tests/kraken/driver.html?testName=json-parse-financial) 18:16:06 INFO - PID 1651 | RSS: Main: 262062080 18:16:06 INFO - PID 1651 | 18:16:08 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49235/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:16:09 INFO - PID 1651 | RSS: Main: 261574656 18:16:09 INFO - PID 1651 | 18:16:10 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:16:11 INFO - PID 1651 | RSS: Main: 261550080 18:16:11 INFO - PID 1651 | 18:16:13 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:16:14 INFO - PID 1651 | RSS: Main: 261640192 18:16:14 INFO - PID 1651 | 18:16:17 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:16:18 INFO - PID 1651 | RSS: Main: 262266880 18:16:18 INFO - PID 1651 | 18:16:21 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:16:22 INFO - PID 1651 | RSS: Main: 262078464 18:16:22 INFO - PID 1651 | 18:16:23 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49235/tests/kraken/driver.html?testName=ai-astar) 18:16:24 INFO - PID 1651 | RSS: Main: 263782400 18:16:24 INFO - PID 1651 | 18:16:24 INFO - PID 1651 | __start_tp_report 18:16:24 INFO - PID 1651 | _x_x_mozilla_page_load 18:16:24 INFO - PID 1651 | _x_x_mozilla_page_load_details 18:16:24 INFO - PID 1651 | |i|pagename|runs| 18:16:24 INFO - PID 1651 | |0;ai-astar;88;179;172;129;119;120;115;119;120;120 18:16:24 INFO - PID 1651 | |1;audio-beat-detection;149;114;115;155;114;118;114;127;174;107 18:16:24 INFO - PID 1651 | |2;audio-dft;196;203;199;213;207;205;196;199;199;191 18:16:24 INFO - PID 1651 | |3;audio-fft;83;73;51;80;65;74;61;47;62;49 18:16:24 INFO - PID 1651 | |4;audio-oscillator;91;72;88;103;106;72;87;76;65;92 18:16:24 INFO - PID 1651 | |5;imaging-gaussian-blur;132;80;94;139;109;93;91;91;93;90 18:16:24 INFO - PID 1651 | |6;imaging-darkroom;98;98;98;98;98;97;98;96;98;125 18:16:24 INFO - PID 1651 | |7;imaging-desaturate;93;93;91;115;105;89;92;88;91;111 18:16:24 INFO - PID 1651 | |8;json-parse-financial;67;65;68;68;68;68;68;68;68;71 18:16:24 INFO - PID 1651 | |9;json-stringify-tinderbox;61;61;62;64;72;62;59;59;59;59 18:16:24 INFO - PID 1651 | |10;stanford-crypto-aes;83;80;103;78;91;110;108;84;83;76 18:16:24 INFO - PID 1651 | |11;stanford-crypto-ccm;157;158;158;152;157;149;157;145;198;178 18:16:24 INFO - PID 1651 | |12;stanford-crypto-pbkdf2;186;190;186;183;187;191;189;234;186;186 18:16:24 INFO - PID 1651 | |13;stanford-crypto-sha256-iterative;68;69;69;68;67;72;72;61;61;84 18:16:24 INFO - PID 1651 | __end_tp_report 18:16:24 INFO - PID 1651 | __start_cc_report 18:16:24 INFO - PID 1651 | _x_x_mozilla_cycle_collect,1025 18:16:24 INFO - PID 1651 | __end_cc_report 18:16:24 INFO - PID 1651 | __startTimestamp1489540584010__endTimestamp 18:16:24 INFO - PID 1651 | 18:16:24 INFO - PID 1651 | ------- Summary: start ------- 18:16:24 INFO - PID 1651 | Number of tests: 14 18:16:24 INFO - PID 1651 | 18:16:24 INFO - PID 1651 | [#0] ai-astar Cycles:10 Average:128.10 Median:124.50 stddev:27.20 (21.9%) stddev-sans-first:24.68 18:16:24 INFO - PID 1651 | Values: 88.0 179.0 172.0 129.0 119.0 120.0 115.0 119.0 120.0 120.0 18:16:24 INFO - PID 1651 | 18:16:24 INFO - PID 1651 | [#1] audio-beat-detection Cycles:10 Average:128.70 Median:122.50 stddev:22.56 (18.4%) stddev-sans-first:22.70 18:16:24 INFO - PID 1651 | Values: 149.0 114.0 115.0 155.0 114.0 118.0 114.0 127.0 174.0 107.0 18:16:24 INFO - PID 1651 | 18:16:24 INFO - PID 1651 | [#2] audio-dft Cycles:10 Average:200.80 Median:201.00 stddev:6.34 (3.2%) stddev-sans-first:6.48 18:16:24 INFO - PID 1651 | Values: 196.0 203.0 199.0 213.0 207.0 205.0 196.0 199.0 199.0 191.0 18:16:24 INFO - PID 1651 | 18:16:24 INFO - PID 1651 | [#3] audio-fft Cycles:10 Average:64.50 Median:69.00 stddev:12.88 (18.7%) stddev-sans-first:11.79 18:16:24 INFO - PID 1651 | Values: 83.0 73.0 51.0 80.0 65.0 74.0 61.0 47.0 62.0 49.0 18:16:24 INFO - PID 1651 | 18:16:24 INFO - PID 1651 | [#4] audio-oscillator Cycles:10 Average:85.20 Median:81.50 stddev:13.67 (16.8%) stddev-sans-first:14.34 18:16:24 INFO - PID 1651 | Values: 91.0 72.0 88.0 103.0 106.0 72.0 87.0 76.0 65.0 92.0 18:16:24 INFO - PID 1651 | 18:16:24 INFO - PID 1651 | [#5] imaging-gaussian-blur Cycles:10 Average:101.20 Median:91.00 stddev:19.46 (21.4%) stddev-sans-first:17.15 18:16:24 INFO - PID 1651 | Values: 132.0 80.0 94.0 139.0 109.0 93.0 91.0 91.0 93.0 90.0 18:16:24 INFO - PID 1651 | 18:16:24 INFO - PID 1651 | [#6] imaging-darkroom Cycles:10 Average:100.40 Median:98.00 stddev:8.67 (8.8%) stddev-sans-first:9.15 18:16:24 INFO - PID 1651 | Values: 98.0 98.0 98.0 98.0 98.0 97.0 98.0 96.0 98.0 125.0 18:16:24 INFO - PID 1651 | 18:16:24 INFO - PID 1651 | [#7] imaging-desaturate Cycles:10 Average:96.80 Median:91.00 stddev:9.76 (10.7%) stddev-sans-first:10.26 18:16:24 INFO - PID 1651 | Values: 93.0 93.0 91.0 115.0 105.0 89.0 92.0 88.0 91.0 111.0 18:16:24 INFO - PID 1651 | 18:16:24 INFO - PID 1651 | [#8] json-parse-financial Cycles:10 Average:67.90 Median:68.00 stddev:1.45 (2.1%) stddev-sans-first:1.50 18:16:24 INFO - PID 1651 | Values: 67.0 65.0 68.0 68.0 68.0 68.0 68.0 68.0 68.0 71.0 18:16:24 INFO - PID 1651 | 18:16:24 INFO - PID 1651 | [#9] json-stringify-tinderbox Cycles:10 Average:61.80 Median:61.50 stddev:3.97 (6.4%) stddev-sans-first:4.20 18:16:24 INFO - PID 1651 | Values: 61.0 61.0 62.0 64.0 72.0 62.0 59.0 59.0 59.0 59.0 18:16:24 INFO - PID 1651 | 18:16:24 INFO - PID 1651 | [#10] stanford-crypto-aes Cycles:10 Average:89.60 Median:81.50 stddev:12.76 (15.7%) stddev-sans-first:13.31 18:16:24 INFO - PID 1651 | Values: 83.0 80.0 103.0 78.0 91.0 110.0 108.0 84.0 83.0 76.0 18:16:24 INFO - PID 1651 | 18:16:24 INFO - PID 1651 | [#11] stanford-crypto-ccm Cycles:10 Average:160.90 Median:157.50 stddev:15.65 (9.9%) stddev-sans-first:16.54 18:16:24 INFO - PID 1651 | Values: 157.0 158.0 158.0 152.0 157.0 149.0 157.0 145.0 198.0 178.0 18:16:24 INFO - PID 1651 | 18:16:24 INFO - PID 1651 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:191.80 Median:188.00 stddev:15.01 (8.0%) stddev-sans-first:15.77 18:16:24 INFO - PID 1651 | Values: 186.0 190.0 186.0 183.0 187.0 191.0 189.0 234.0 186.0 186.0 18:16:24 INFO - PID 1651 | 18:16:24 INFO - PID 1651 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.10 Median:69.00 stddev:6.47 (9.4%) stddev-sans-first:6.85 18:16:24 INFO - PID 1651 | Values: 68.0 69.0 69.0 68.0 67.0 72.0 72.0 61.0 61.0 84.0 18:16:24 INFO - PID 1651 | -------- Summary: end -------- 18:16:24 INFO - PID 1651 | 18:16:24 INFO - TEST-INFO | 1651: exit 0 18:16:24 INFO - TEST-OK | kraken | took 61301ms 18:16:24 INFO - SUITE-END | took 1178s 18:16:25 INFO - Completed test suite (00:19:38) 18:16:25 INFO - javascript benchmark 18:16:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7851.308900688818, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2993.655729591096, 3033.742131918787, 3137.5607414961896, 3387.661233876614, 3479.112826229311, 4132.917341653173, 4609.769511524423, 5247.947520524794, 6006.279246490421, 6037.728302226399, 5884.382139875315, 5888.381719919411, 5895.764169433228, 5922.822315330547, 5937.703114844251, 4382.605565499104, 5477.123660214366, 5483.451654834525, 5517.972410137943, 5572.637778544402, 5461.290032295796, 5521.944780552203, 5526.696031718274, 5536.446355364472, 5540.141278101901, 4485.215087359716, 5357.249985002103, 5438.782448702067, 5527.640703354289, 5541.972290138564, 5356.0, 5396.946030539683, 5432.049391356497, 5445.401005889349, 5478.698671573062, 5386.245925570423, 5389.8113566025395, 5393.002294575477, 5403.972980135113, 5426.131818908995, 5877.9118313225335, 6031.487323577501, 6036.0945858121195, 6052.848678783022, 6082.635041897501, 6285.245770507523, 6335.588186767845, 6344.080108384304, 6406.1351717518, 6408.0, 5413.675179489204, 6436.806895793134, 6446.194225721785, 6453.548251622388, 6468.3855033771715, 5016.949830501721, 6168.167297414837, 6182.598131121463, 6186.536009799193, 6187.288461826947, 6330.588511746721, 6401.8719625608155, 6471.935280647133, 6519.119918810995, 6598.538102332886, 6213.00591905293, 6324.367563243639, 6336.366363363627, 6341.651209183447, 6342.714577844008, 6282.842928926813, 6335.334789847, 6338.968305158444, 6392.552521323556, 6402.743890244431, 6297.716602752887, 6371.076193951851, 6376.872462550723, 6390.584612000205, 6391.328910464427, 6140.4473597376455, 6365.713542890581, 6376.585521941059, 6378.681065946684, 6382.489400847921, 5124.718140502234, 5149.0474262261605, 5180.766865491062, 5181.1969144782615, 5181.896362072737, 4643.257078867433, 4662.067586482717, 4678.906421871544, 4679.087577922272, 4724.173269677793, 6145.631262124287, 6181.258249010148, 6191.628502289877, 6195.380461953859, 6214.937850621436, 6321.273053598895, 6338.651374174465, 6484.319146489551, 6486.124373209651, 6515.283318834924, 6131.132004888217, 6160.0, 6194.26560563043, 6199.380061993855, 6223.315435302113, 5577.96807590597, 5664.150377443334, 5765.04876695349, 5779.8555036124435, 5801.01382764931, 5537.5569954404355, 6052.455279024909, 6403.327650596713, 6443.548951573345, 6671.766488172891, 6337.7781777637565, 6423.229212494531, 6464.256610489854, 6471.7734879279, 6515.576487528296, 6702.430293425114, 6705.497087718538, 6711.127553418024, 6718.731250750111, 6726.932730672631, 6308.243010838729, 6359.3640635936035, 6399.968000159969, 6402.903956440564, 6412.294647588855, 6127.769884593299, 6326.43062124411, 6415.069814876723, 6420.5826621271335, 6481.967590162019, 6263.217097862767, 6302.936970630235, 6321.0, 6323.241211054703, 6323.304436512072, 5940.287165540163, 6192.659403732838, 6232.002879539252, 6290.937090629035, 6314.778982735582, 4871.780769865293, 6154.969225153845, 6259.029850373199, 6283.465905397909, 6291.779787707408, 6280.591761535668, 6317.020861766434, 6318.62088274705, 6320.905186422116, 6334.113224148531, 6301.0, 6301.0, 6304.148939893055, 6324.3991820776955, 6332.936670633235], "value": 5865.858458401138, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [724.4132252875172, 774.399840123904, 801.8837268596054, 929.5398777605086, 935.8409070458026, 37454.0, 38040.61959380409, 38058.619413805885, 38074.42888356677, 38097.619023809755, 36822.44766328507, 36990.4451433228, 37146.257074858484, 37253.0, 37482.875513734565, 7690.923090769076, 7849.882251766228, 10585.629502967398, 10859.565617375296, 10875.945620271888, 10857.728556786104, 10955.17836162287, 11011.61459348923, 11012.614558490455, 11019.008289253965, 10934.617288394908, 11023.007929286403, 11027.558897644085, 11033.337999720043, 11060.446977651085, 10971.945140274287, 10979.83530247047, 11012.559497620086, 11029.889701102966, 11035.99999999992, 10799.946000269949, 10887.618933337295, 10891.67324980244, 10892.237543371966, 10897.346159230392, 37920.672776452695, 38139.0, 38176.04559885997, 38222.0, 38329.616703832886, 3771.302309072803, 3792.126483466411, 3810.0, 3816.351220292529, 3959.0300376407963, 23902.0, 27866.58200127, 28621.28446788826, 28636.856815715997, 28749.56875646867, 2900.6664233612983, 3132.3108916038436, 3159.526071089332, 3242.2866969266724, 3242.5622540956906, 257653.0, 263646.6817665899, 265134.6973060547, 353965.0, 367652.0, 45831.0, 46098.0, 46113.76943115263, 46125.7693711536, 46173.53826461759, 48400.0, 50449.0, 50671.493285067416, 50687.0, 51173.720656983875, 14407.207603581903, 14535.27323633814, 14554.199519026555, 14580.927095364455, 14699.41202351894, 9954.601815927426, 11661.0, 11796.410179491162, 11806.996405305645, 11840.28958262507, 13666.93166534161, 13677.24775137377, 13683.179009259477, 13738.900887928941, 13811.792823107662, 4739.597134243559, 5063.797448102035, 6021.548383871227, 6052.576319657582, 6097.603655762361, 809.668036105194, 922.8108237811233, 924.4961495984704, 962.1100482054072, 976.3751199232497, 22571.43571410728, 26375.86812065966, 27363.589546156825, 27681.446371072467, 28063.57904631432, 1012.2812802910016, 1015.1523477896039, 1043.5721354244874, 1045.1899777672365, 1056.7727938493108, 12804.679883002813, 14232.359543820552, 14465.710685786436, 14558.563243102511, 14560.927195363955, 360143.19928400713, 366437.0, 367665.0, 367913.369096241, 411244.0, 46006.0, 56545.7172714142, 57349.71325143347, 57353.713231433576, 57397.426025740046, 1211.4487908001838, 1221.3343727668441, 1381.3162484570203, 1410.9082909611047, 1432.298173894805, 25861.70691465457, 27038.78325475319, 27736.72263277422, 27932.720672793013, 27950.30124246829, 48032.759836200596, 48429.75785121052, 48454.0, 48722.0, 48765.0, 404611.9769401134, 479654.0, 481007.0, 482142.5892870513, 483165.0, 32695.0, 33178.834105829315, 33357.99926002224, 33387.0, 33462.0, 36535.0, 40321.0, 40479.59520404758, 40659.390109148975, 41163.588364117175, 32327.67609759969, 32718.83640581782, 33783.662163379035, 34477.48283775695, 34791.47812782861, 23132.0, 32493.0, 33207.667923320456, 33405.33189336151, 35777.0, 34611.82694086513, 35273.823630881685, 35618.46572301366, 35891.64108358987, 35953.28093438169, 29842.403151937273, 31146.68853311438, 31279.84360078185, 31291.53062704107, 31327.530087048257, 19167.52081197981, 19756.0, 21240.362789116352, 21358.78641213568, 24154.396140096636], "value": 18425.963731042528, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [364.41875209041575, 395.81594558530315, 410.3332085361286, 411.0914878119357, 428.4922366995111, 20778.376648700545, 21533.569328613437, 21606.0, 21613.567728645437, 22772.65841012382, 16274.918625406857, 16629.91685041573, 17313.96116233027, 22880.65679014816, 22900.541989160247, 5695.430456954313, 5769.653820770767, 6249.875002499959, 6603.3396660334065, 6613.933860661404, 6304.936950630481, 6506.056621789838, 6519.217693876742, 6590.835229119262, 6615.5369124161325, 6571.112899758519, 6589.736410543596, 6589.967050164766, 6609.6695165241545, 6622.470202383798, 6345.619262844244, 6568.080468734357, 6576.0135979602965, 6621.536492445531, 6640.535162538624, 6176.4749996250375, 6441.806745797634, 6446.677666116675, 6468.547201695883, 6493.383128602775, 21265.36203913885, 26844.46311073787, 27510.0, 27823.86088069567, 27898.0, 3337.332533493287, 3338.549295845054, 3364.882229121969, 3370.865165393381, 3536.3811333016874, 15044.849551504454, 15655.608609784733, 15782.763258551131, 15854.207289635473, 16587.0, 1947.221111555375, 1994.5140870051905, 2005.46855083403, 2013.2047841102828, 2033.196887229536, 158114.0, 161144.0, 162206.37793622032, 162862.0, 166248.0, 22330.0, 22589.77410225877, 22663.433414164778, 22856.857157142076, 22993.0, 26473.86763066211, 37069.0, 37210.883673489836, 37309.0, 37391.252174956346, 10373.533191006423, 10565.471726413802, 10646.148308135485, 10749.19381046409, 10866.891331086747, 6930.7227710891, 8394.0, 8402.28580570646, 8408.915910840813, 8575.099614540508, 10619.469026548642, 10707.875673054374, 10752.731181720519, 10798.460076996276, 10869.021788039114, 3774.5659249186147, 3810.7713537187856, 4437.179121862466, 4462.41988541494, 4487.439070116236, 970.2529052629436, 986.7829077602916, 988.8640982702315, 1003.5132960514145, 1041.770810421721, 18610.976396298334, 19150.233990640496, 21611.459713507287, 23122.65316020261, 23316.300510984696, 880.4937161132375, 995.4873240281261, 1021.8927012663712, 1051.9053285204368, 1083.247143235444, 11956.282623042645, 12254.571090011807, 12341.75316493665, 12410.75178496443, 12410.937945310396, 670721.6463917746, 671614.0, 687654.5617271882, 702280.0, 720628.0, 117924.0, 122084.77915220734, 142136.0, 159982.0, 160867.0, 1206.1677442564603, 1260.3824126178106, 1303.9413226404833, 1309.5678426119548, 1310.744404841066, 21505.56988860183, 21655.891720541298, 21817.781822181576, 21926.780732192474, 22001.449963750394, 57698.0, 57847.132293014794, 57976.0, 58299.0, 58967.70516147392, 49338.75330623324, 80560.79158812505, 83237.0, 83807.5809620948, 85972.14027859642, 11384.544618215179, 11704.239224450725, 11796.94101529487, 12060.879391206327, 12245.755084898074, 9893.802123957625, 13142.039014496228, 13645.727085458037, 13651.11267767592, 13780.931095344458, 9876.703698889045, 10917.344959302467, 11387.0, 11532.019778318936, 11784.057275418118, 11250.212485125963, 11275.32348059119, 11356.318620882774, 11480.196386253216, 11683.0, 11741.29552226869, 11788.29270243788, 11970.401479926142, 12063.276203427822, 12081.214721043105, 9118.726438206864, 10135.682361292984, 12033.278003319829, 12042.0, 12196.817047744113, 11498.48256828428, 11541.192116551762, 11761.235519691192, 11809.0, 11916.582919597773], "value": 11655.628172307095, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1499.542639494955, 1522.3453914816632, 1538.3615799443232, 1559.485369827957, 1561.7032763774885, 10516.631917882876, 10743.19426043046, 10961.671149865508, 10987.011168994788, 11106.555737770479, 10652.573897044129, 10852.403117828537, 10858.402787846666, 10884.891151088486, 10936.507857146447, 2310.1683393978155, 2350.576896158691, 2352.176738141654, 2354.8587084774967, 2358.8584684918874, 1965.4005528313858, 2268.6483595042714, 2305.7809508096702, 2305.988470057656, 2308.6883270758485, 2280.5780930527903, 2283.942901427469, 2292.6904867842795, 2301.3671240408853, 2309.515001849614, 2246.29241788836, 2254.966175507369, 2266.739324977624, 2268.4215525041172, 2277.350954977832, 2271.0, 2340.8127349811975, 2343.379004563792, 2345.8475199112004, 2345.906163753448, 11084.390358530278, 11107.111431085494, 11108.0, 11174.776504469864, 11194.832077518762, 5317.46825317469, 5477.3427188737205, 5504.64219825714, 5514.5864060195245, 5554.0, 3145.7955232910017, 3364.1253274148653, 3367.0, 3451.620321764604, 3508.947365789515, 1157.2882677153575, 1168.760404117154, 1191.606769765975, 1201.0331682995186, 1237.0227520258984, 15008.624784380369, 15045.548633541011, 15087.24563771807, 15165.696686066216, 15205.239738013166, 4328.632066274339, 4555.339475775994, 4584.862454126382, 4679.532046795293, 4697.365855609449, 11296.54813807455, 11335.829962550568, 11368.317900925971, 11368.715782105348, 11389.259698119597, 5424.755885985141, 5460.426655201226, 5507.669539827623, 5527.613067085346, 5531.446855314517, 4934.013197360542, 4977.950220497749, 5001.699898006059, 5054.9241761373605, 5140.485951404829, 3698.8890333290046, 3700.1859590889962, 3801.486799282117, 3821.828017739153, 3877.2245550889934, 1024.933379330341, 1035.6219979707503, 1037.2324479884983, 1051.5057922776282, 1052.85786418834, 767.2864236260332, 811.7970507373157, 888.493558671564, 905.4250550900226, 938.8075444533854, 5237.371515418098, 5697.7464957709235, 6342.492600592034, 6612.471002319803, 6899.724011039602, 818.5743413424985, 1025.2361990317113, 1035.4201647077662, 1046.5865982936698, 1053.578568572577, 4185.079282557833, 4189.889679235005, 4203.43253660758, 4326.956730432718, 4360.978195109004, 13524.93237533806, 13546.864531354757, 13985.86014139866, 14011.649708757363, 14047.578572642837, 11858.169928105122, 12252.264864108181, 13397.928165746716, 13980.930095349662, 13990.790138147935, 7743.341815945595, 8270.462419942685, 8510.276626486695, 9998.750031249132, 10067.597296108073, 6616.702248398929, 6647.800565983028, 6649.235337936006, 6748.223954245324, 6756.391924726799, 11423.714407139889, 12288.447019883948, 12310.630681079581, 12366.62900112998, 12447.502099915902, 12341.444634991267, 12346.13577049598, 12460.314682692539, 12728.299943503196, 12823.03827212944, 8242.340612750846, 8419.83160336802, 8432.704855330034, 8491.617877195418, 8516.190961858614, 8824.426412283181, 9121.133492318218, 9283.11810378013, 10121.342112762646, 10253.33353332031, 8061.758147255592, 8190.058143313595, 8195.71315003972, 8208.425410221227, 8292.502449853027, 8201.30288925424, 8630.78423039404, 8684.305255579413, 8761.386702930733, 8829.558522074, 6668.599594085296, 7475.36459400957, 7669.156392796676, 7684.961575192088, 7816.0, 4625.7918393673035, 5742.454466825645, 5876.08920617305, 5887.1757953885635, 5949.07789292643, 5210.557102646318, 5824.213731146241, 6006.189164462741, 6077.2099627049965, 6102.956912984828], "value": 4975.978557463873, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [374.36171327885955, 387.85455454204674, 389.9805009749512, 393.31759397445427, 399.93001224785667, 5102.668326558771, 6094.207752992105, 6257.249130104383, 6271.686415679215, 6385.648789316591, 5039.395272567297, 5803.245578074855, 6127.724252408641, 6134.754609815602, 6137.508999280058, 4060.979695101528, 5007.699538027712, 5019.824306149286, 5029.1199040168, 5052.671576347544, 4698.624110071203, 4878.024598331343, 4945.455999840015, 4958.082754690394, 5003.824866129687, 4048.6356227939477, 4957.925631115536, 4962.337616898343, 4987.351644286237, 5011.824586139486, 4059.6143366380147, 4979.751012449363, 5006.22403527452, 5006.924896126561, 5011.273365362002, 4418.513963464016, 4508.977455112704, 4555.567221113989, 4563.680542362036, 4580.290055041474, 4803.663743537953, 4808.903821923577, 5391.622586418952, 5940.405959404068, 5960.344362120163, 5339.279197308352, 5420.83737487876, 5435.701036442994, 5821.330546987108, 5828.115083033926, 6506.707198176094, 6513.967430162867, 6530.734632683658, 6565.704543295516, 6573.835654108638, 4180.26845302074, 4778.685861388111, 5088.0, 5111.1566591512355, 5120.897582048376, 5952.285725712899, 6113.449789518964, 6153.907691384633, 6887.483438742064, 6935.202451718016, 4424.491183513937, 5305.991861546294, 5358.624896257303, 5366.409694933554, 5385.8114965976, 4399.680095971195, 5397.8110766123, 5427.565794736412, 5438.700871452029, 5455.781768729206, 5588.842304098172, 5701.686407247641, 5822.272215973004, 5836.986239747281, 5845.240118784531, 6460.481786780103, 6519.4132528072705, 6532.804015879531, 6559.882527457762, 6567.2447668518735, 1477.0842077911764, 1762.2598508626409, 1813.7642106526066, 1821.1986725840588, 1830.0, 1143.7540928700369, 1182.2197349749124, 1312.9146605470614, 1356.647271709343, 1367.3778430813957, 5234.319538459976, 5371.459379586398, 6032.306284777307, 6128.17269668598, 6179.474744646755, 6774.983752437075, 6807.285235050347, 6831.882116543888, 6839.829004274833, 6853.725850966005, 5545.390007099216, 5927.940720592739, 6059.515238780975, 6147.569670123048, 6200.410960958701, 3167.7624178186265, 3573.213892943548, 3577.01632051188, 3582.140286331262, 3587.9282414351565, 5697.6296540724725, 6774.525783195129, 6931.861362772817, 7019.684114214872, 7045.534063077984, 6826.4538836892925, 6841.0, 6915.204751453647, 6958.617276049765, 6979.546329488567, 5920.963831329586, 6268.432891777055, 7019.192792828788, 7029.89455158173, 7069.540479868792, 5313.4304498130805, 6562.868742625216, 6835.521513494008, 6848.863022739617, 6894.482913781587, 6133.202683651097, 6368.363163683594, 6689.09697190873, 6705.0612914193025, 6750.561213521106, 6035.728392222272, 6842.692078856563, 7017.298270172942, 7053.365197132282, 7082.681279342545, 3939.1727737175515, 4405.735655860659, 4461.977690111528, 5058.0, 5126.538611524831, 5643.971780141237, 6210.689465526796, 6278.340774218641, 6742.325767423218, 6871.347222013901, 6597.668177570296, 6610.636414997221, 6619.470442364695, 6655.534112612264, 6678.198616166092, 5793.725380416302, 6004.519638428827, 6557.491741918051, 6582.275949645631, 6617.371349721769, 5581.609287349846, 5885.94114058871, 6094.39056094387, 6423.839404014937, 6457.128287681103, 4936.457724272074, 6503.187101612299, 6545.498158485188, 6572.211334639874, 6630.900536492053, 6433.906235939808, 6474.924410904782, 6491.383318584727, 6497.62836564641, 6506.544541882023], "value": 4951.74951297266, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [689.4656641103145, 690.4717890813529, 699.8950157476381, 712.2130046298839, 772.4361216312092, 14927.850721492781, 15250.313735881884, 15447.768283475743, 15468.0, 15517.146556939364, 12011.219270747395, 13648.38582263798, 14542.345594448248, 14547.418103275857, 15082.849171508282, 846.8010017645848, 920.2132176988662, 950.2018304624114, 956.3114557518576, 957.7270477913796, 897.757605446529, 940.2008292951006, 953.3040880157489, 960.5581432541039, 961.1829944547148, 992.4343124419084, 997.975050623733, 1005.3565717940523, 1006.9093781559658, 1011.1304278320638, 995.8804943406801, 1001.4692213127017, 1002.7292630989665, 1004.7287232447198, 1007.1791489935679, 742.3986570877606, 746.4438992950287, 747.8504299140194, 747.9102507699057, 748.1060133140899, 15893.761593576106, 16079.517614471584, 16504.66990660192, 16616.6676666466, 16859.40992065284, 14355.425782968668, 14616.0, 14693.706125877423, 14739.263036848115, 14780.704385912222, 10127.949360253226, 11327.660170194826, 11691.649250522498, 11967.1622986391, 12186.939065304705, 3699.5560532735976, 3879.72841901067, 3887.4168874668744, 3893.1045859452483, 3899.629535194152, 108410.45794771054, 110000.0, 110558.0, 113000.86999129986, 113619.43190284078, 9563.856542151872, 10697.99281470638, 11185.552577896955, 11568.074554035826, 11677.88322116768, 24354.75645243525, 24521.754782452303, 24899.004039838204, 24925.626115607916, 25006.999720010997, 7697.499662521918, 7815.3356964657505, 7834.804129896685, 7924.801879953047, 8061.355091592659, 3937.468441760383, 4181.414601955728, 4259.467566554181, 4269.61573458384, 4272.700910936204, 3159.526071089355, 3533.7349698772696, 3557.4308110702164, 3559.555055618048, 3563.1448452371246, 635.5397385575573, 642.9710663020176, 644.9806505804834, 646.6314200905439, 651.0689713709346, 654.2443477783168, 654.991313377403, 664.8204984654117, 674.1438373265925, 674.4671709349657, 9582.210844359839, 10036.567878814833, 10070.560603497202, 10409.167266618653, 10431.94784026075, 684.7397988764337, 686.8111269400855, 697.8953157026486, 702.5468572770534, 711.1750369571273, 3824.0, 4548.295014272793, 4908.730019848871, 4911.45973942866, 4940.827071052496, 77302.0, 81425.0, 87332.12667873366, 95016.0, 100352.4982375098, 71072.0, 71789.20526986763, 74099.62950185215, 75072.0, 76224.61887690525, 64880.67559662172, 67806.0, 71526.0, 78863.21136788558, 80513.98715032054, 9417.340786145178, 10497.790044199226, 10977.231593788358, 10995.835062473909, 11190.32858028521, 42231.366529501465, 46082.0, 49739.253911192085, 49983.50049498521, 50824.98350032905, 60126.0, 61899.0, 62143.0, 63508.0, 65877.35306617373, 13158.671033224246, 13351.0, 13462.903532187456, 13606.047576669538, 13967.371468283749, 14459.855401445851, 14466.638334041732, 14522.20127892976, 14627.488037918622, 14661.63345916318, 13791.931040344734, 13856.099353541988, 13931.721365572834, 14098.929505352407, 14251.025038812199, 10565.366078035342, 12469.314187719763, 12682.112252142262, 12727.74544509086, 13091.214527128403, 10764.246502744732, 13516.25611842886, 13643.86356136426, 13724.862751372359, 13783.586492405244, 10229.948850255701, 10892.564297428014, 11036.172287078662, 11093.16801239894, 11402.486888090221, 9229.169374756304, 10159.339642923187, 10325.277230593787, 11501.194916355775, 11758.823617645914], "value": 7545.399395833148, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1546.7999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 179.0, 172.0, 129.0, 119.0, 120.0, 115.0, 119.0, 120.0, 120.0], "value": 128.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 114.0, 115.0, 155.0, 114.0, 118.0, 114.0, 127.0, 174.0, 107.0], "value": 128.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [196.0, 203.0, 199.0, 213.0, 207.0, 205.0, 196.0, 199.0, 199.0, 191.0], "value": 200.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 73.0, 51.0, 80.0, 65.0, 74.0, 61.0, 47.0, 62.0, 49.0], "value": 64.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 72.0, 88.0, 103.0, 106.0, 72.0, 87.0, 76.0, 65.0, 92.0], "value": 85.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 80.0, 94.0, 139.0, 109.0, 93.0, 91.0, 91.0, 93.0, 90.0], "value": 101.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 98.0, 98.0, 98.0, 98.0, 97.0, 98.0, 96.0, 98.0, 125.0], "value": 100.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 91.0, 115.0, 105.0, 89.0, 92.0, 88.0, 91.0, 111.0], "value": 96.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 68.0, 68.0, 68.0, 68.0, 68.0, 68.0, 68.0, 71.0], "value": 67.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 62.0, 64.0, 72.0, 62.0, 59.0, 59.0, 59.0, 59.0], "value": 61.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 80.0, 103.0, 78.0, 91.0, 110.0, 108.0, 84.0, 83.0, 76.0], "value": 89.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 158.0, 158.0, 152.0, 157.0, 149.0, 157.0, 145.0, 198.0, 178.0], "value": 160.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 190.0, 186.0, 183.0, 187.0, 191.0, 189.0, 234.0, 186.0, 186.0], "value": 191.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 69.0, 68.0, 67.0, 72.0, 72.0, 61.0, 61.0, 84.0], "value": 69.1, "unit": "score"}]}]} 18:16:25 INFO - Return code: 0 18:16:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:16:25 ERROR - # TBPL SUCCESS # 18:16:25 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:16:25 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:16:25 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:16:25 INFO - 2017-03-14 18:16:25.333 screenresolution[1656:10960] starting screenresolution argv=screenresolution get 18:16:25 INFO - 2017-03-14 18:16:25.336 screenresolution[1656:10960] Display 0: 1600x1200x32@60 18:16:25 INFO - 2017-03-14 18:16:25.342 screenresolution[1657:10963] starting screenresolution argv=screenresolution list 18:16:25 INFO - Available Modes on Display 0 18:16:25 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:16:25 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:16:25 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:16:25 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:16:25 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:16:25 INFO - Intel Iris: 18:16:25 INFO - Chipset Model: Intel Iris 18:16:25 INFO - Type: GPU 18:16:25 INFO - Bus: Built-In 18:16:25 INFO - VRAM (Dynamic, Max): 1536 MB 18:16:25 INFO - Vendor: Intel (0x8086) 18:16:25 INFO - Device ID: 0x0a2e 18:16:25 INFO - Revision ID: 0x0009 18:16:25 INFO - Displays: 18:16:25 INFO - Display: 18:16:25 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:16:25 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:16:25 INFO - Display Serial Number: 1600x1200 60 18:16:25 INFO - Main Display: Yes 18:16:25 INFO - Mirror: Off 18:16:25 INFO - Online: Yes 18:16:25 INFO - Rotation: Supported 18:16:25 INFO - Return code: 0 18:16:25 INFO - Running post-action listener: _resource_record_post_action 18:16:25 INFO - [mozharness: 2017-03-15 01:16:25.583705Z] Finished run-tests step (success) 18:16:25 INFO - Running post-run listener: _resource_record_post_run 18:16:25 INFO - Total resource usage - Wall time: 1199s; CPU: 54.0%; Read bytes: 40200704; Write bytes: 515808256; Read time: 389; Write time: 1905 18:16:25 INFO - TinderboxPrint: CPU usage
54.2% 18:16:25 INFO - TinderboxPrint: I/O read bytes / time
40,200,704 / 389 18:16:25 INFO - TinderboxPrint: I/O write bytes / time
515,808,256 / 1,905 18:16:25 INFO - TinderboxPrint: CPU idle
2,199.5 (45.8%) 18:16:25 INFO - TinderboxPrint: CPU system
963.9 (20.1%) 18:16:25 INFO - TinderboxPrint: CPU user
1,634.4 (34.1%) 18:16:25 INFO - TinderboxPrint: Swap in / out
250,404,864 / 0 18:16:25 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 203704832; Write bytes: 203662848; Read time: 15645; Write time: 465 18:16:25 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 38361600; Write bytes: 301356544; Read time: 368; Write time: 1407 18:16:26 INFO - Running post-run listener: _upload_blobber_files 18:16:26 INFO - Blob upload gear active. 18:16:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:16:26 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 18:16:26 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'] 18:16:26 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 18:16:26 INFO - (blobuploader) - INFO - Open directory for files ... 18:16:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:16:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:16:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:16:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:16:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:16:29 INFO - (blobuploader) - INFO - Done attempting. 18:16:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:16:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:16:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:16:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:16:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:16:30 INFO - (blobuploader) - INFO - Done attempting. 18:16:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 18:16:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:16:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:16:31 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 18:16:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:16:31 INFO - (blobuploader) - INFO - Done attempting. 18:16:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:16:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:16:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:16:34 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:16:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:16:34 INFO - (blobuploader) - INFO - Done attempting. 18:16:34 INFO - (blobuploader) - INFO - Iteration through files over. 18:16:34 INFO - Return code: 0 18:16:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:16:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:16:34 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0ef8bf6cc108cc38ce696d230966ebc27357fe907bf164934934b3ba703a769294b3f286df03ab3ced636adc411c8b259d5dd53b500f175dd6a5140b2f6763c5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/101fe7dcad56fd23fda6e48a7405d09c31a68f9081e159c09ae9fd9b2a1e7a22678d51b2cf58db684ad4512e849a8a32329928af51e6baf716bd090135727416", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bbf60935449372d3d64895f61d1287ed57b215b6f9eaaeed0159e0dfe25a6fe8d9bde9649727f57d3481e491477527b2bbb5f3db849ec7392ffd4c35c7b548e1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f7b399095878dcec3551d22269f98517bd0d55da8f4978b11073d33980a783c85053a9d6d2c7a13a54c981c77b1a405dbe6cfa8f567a1a5a645baf0a4936e19e"} 18:16:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:16:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:16:34 INFO - Contents: 18:16:34 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0ef8bf6cc108cc38ce696d230966ebc27357fe907bf164934934b3ba703a769294b3f286df03ab3ced636adc411c8b259d5dd53b500f175dd6a5140b2f6763c5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/101fe7dcad56fd23fda6e48a7405d09c31a68f9081e159c09ae9fd9b2a1e7a22678d51b2cf58db684ad4512e849a8a32329928af51e6baf716bd090135727416", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bbf60935449372d3d64895f61d1287ed57b215b6f9eaaeed0159e0dfe25a6fe8d9bde9649727f57d3481e491477527b2bbb5f3db849ec7392ffd4c35c7b548e1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f7b399095878dcec3551d22269f98517bd0d55da8f4978b11073d33980a783c85053a9d6d2c7a13a54c981c77b1a405dbe6cfa8f567a1a5a645baf0a4936e19e"} 18:16:34 INFO - Running post-run listener: copy_logs_to_upload_dir 18:16:34 INFO - Copying logs to upload dir... 18:16:34 INFO - mkdir: /builds/slave/test/build/upload/logs 18:16:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1285.556745 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2017-03-14 18:16:34.100265) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-14 18:16:34.103857) ========= 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.5bwEt4hO0b/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.I1bg8vdDKe/Listeners TMPDIR=/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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/0ef8bf6cc108cc38ce696d230966ebc27357fe907bf164934934b3ba703a769294b3f286df03ab3ced636adc411c8b259d5dd53b500f175dd6a5140b2f6763c5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/101fe7dcad56fd23fda6e48a7405d09c31a68f9081e159c09ae9fd9b2a1e7a22678d51b2cf58db684ad4512e849a8a32329928af51e6baf716bd090135727416", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bbf60935449372d3d64895f61d1287ed57b215b6f9eaaeed0159e0dfe25a6fe8d9bde9649727f57d3481e491477527b2bbb5f3db849ec7392ffd4c35c7b548e1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f7b399095878dcec3551d22269f98517bd0d55da8f4978b11073d33980a783c85053a9d6d2c7a13a54c981c77b1a405dbe6cfa8f567a1a5a645baf0a4936e19e"} build_url:https://queue.taskcluster.net/v1/task/eUbnioplRtahrrdxjtWT1Q/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011036 build_url: 'https://queue.taskcluster.net/v1/task/eUbnioplRtahrrdxjtWT1Q/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/0ef8bf6cc108cc38ce696d230966ebc27357fe907bf164934934b3ba703a769294b3f286df03ab3ced636adc411c8b259d5dd53b500f175dd6a5140b2f6763c5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/101fe7dcad56fd23fda6e48a7405d09c31a68f9081e159c09ae9fd9b2a1e7a22678d51b2cf58db684ad4512e849a8a32329928af51e6baf716bd090135727416", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bbf60935449372d3d64895f61d1287ed57b215b6f9eaaeed0159e0dfe25a6fe8d9bde9649727f57d3481e491477527b2bbb5f3db849ec7392ffd4c35c7b548e1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f7b399095878dcec3551d22269f98517bd0d55da8f4978b11073d33980a783c85053a9d6d2c7a13a54c981c77b1a405dbe6cfa8f567a1a5a645baf0a4936e19e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-14 18:16:34.137600) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-14 18:16:34.137903) ========= 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.5bwEt4hO0b/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.I1bg8vdDKe/Listeners TMPDIR=/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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.005166 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-14 18:16:34.186510) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-14 18:16:34.186822) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-14 18:16:34.187162) ========= ========= Total master_lag: 0.18 =========