builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0314 starttime: 1490405430.38 results: success (0) buildid: 20170324170416 builduid: d6b27b42eae74ef4a61ce685b2a505b9 revision: f9acfdca68a45c8cecf54f5a1bfc3b2a4baa52a3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-24 18:30:30.383949) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-24 18:30:30.384498) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-24 18:30:30.384782) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-24 18:30:30.410798) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-24 18:30:30.411215) ========= 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.cM93edOhS7/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.RcqsQUQwRe/Listeners TMPDIR=/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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-24 18:30:30-- 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% 7.74M=0.002s 2017-03-24 18:30:30 (7.74 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.334649 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-24 18:30:30.771142) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-24 18:30:30.771725) ========= 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.cM93edOhS7/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.RcqsQUQwRe/Listeners TMPDIR=/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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.021444 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-24 18:30:30.822404) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-24 18:30:30.822905) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f9acfdca68a45c8cecf54f5a1bfc3b2a4baa52a3 --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 f9acfdca68a45c8cecf54f5a1bfc3b2a4baa52a3 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.cM93edOhS7/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.RcqsQUQwRe/Listeners TMPDIR=/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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-24 18:30:31,034 truncating revision to first 12 chars 2017-03-24 18:30:31,034 Setting DEBUG logging. 2017-03-24 18:30:31,035 attempt 1/10 2017-03-24 18:30:31,035 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f9acfdca68a4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-24 18:30:32,454 unpacking tar archive at: mozilla-central-f9acfdca68a4/testing/mozharness/ program finished with exit code 0 elapsedTime=1.684832 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-24 18:30:32.532678) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-24 18:30:32.532992) ========= script_repo_revision: f9acfdca68a45c8cecf54f5a1bfc3b2a4baa52a3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-24 18:30:32.533385) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-24 18:30:32.533644) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-24 18:30:32.553331) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2017-03-24 18:30:32.553713) ========= /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.cM93edOhS7/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.RcqsQUQwRe/Listeners TMPDIR=/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 18:30:32 INFO - MultiFileLogger online at 20170324 18:30:32 in /builds/slave/test 18:30:32 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 18:30:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:30:32 INFO - {'append_to_log': False, 18:30:32 INFO - 'base_work_dir': '/builds/slave/test', 18:30:32 INFO - 'blob_upload_branch': 'Firefox', 18:30:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:30:32 INFO - 'branch': 'Firefox', 18:30:32 INFO - 'buildbot_json_path': 'buildprops.json', 18:30:32 INFO - 'config_files': ('talos/mac_config.py',), 18:30:32 INFO - 'default_actions': ('clobber', 18:30:32 INFO - 'read-buildbot-config', 18:30:32 INFO - 'download-and-extract', 18:30:32 INFO - 'populate-webroot', 18:30:32 INFO - 'create-virtualenv', 18:30:32 INFO - 'install', 18:30:32 INFO - 'run-tests'), 18:30:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:30:32 INFO - 'download_minidump_stackwalk': True, 18:30:32 INFO - 'download_symbols': 'ondemand', 18:30:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:30:32 INFO - 'tooltool.py': '/tools/tooltool.py', 18:30:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:30:32 INFO - '/tools/misc-python/virtualenv.py')}, 18:30:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:30:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:30:32 INFO - 'gecko_profile': False, 18:30:32 INFO - 'gecko_profile_interval': 0, 18:30:32 INFO - 'installer_path': 'installer.exe', 18:30:32 INFO - 'log_level': 'info', 18:30:32 INFO - 'log_name': 'talos', 18:30:32 INFO - 'log_to_console': True, 18:30:32 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 18:30:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 18:30:32 INFO - 'opt_config_files': (), 18:30:32 INFO - 'pip_index': False, 18:30:32 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:30:32 INFO - 'cmd': ('bash', 18:30:32 INFO - '-c', 18:30:32 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:30:32 INFO - 'enabled': True, 18:30:32 INFO - 'halt_on_failure': False, 18:30:32 INFO - 'name': 'check_screen_resolution'},), 18:30:32 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:30:32 INFO - 'cmd': ('bash', 18:30:32 INFO - '-c', 18:30:32 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:30:32 INFO - 'enabled': True, 18:30:32 INFO - 'halt_on_failure': False, 18:30:32 INFO - 'name': 'check_screen_resolution'},), 18:30:32 INFO - 'run_cmd_checks_enabled': True, 18:30:32 INFO - 'suite': 'dromaeojs-e10s', 18:30:32 INFO - 'system_bits': '32', 18:30:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:30:32 INFO - 'title': 't-yosemite-r7-0314', 18:30:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:30:32 INFO - 'use_talos_json': True, 18:30:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:30:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:30:32 INFO - 'work_dir': 'build'} 18:30:32 INFO - [mozharness: 2017-03-25 01:30:32.881527Z] Running clobber step. 18:30:32 INFO - Running pre-action listener: _resource_record_pre_action 18:30:32 INFO - Running main action method: clobber 18:30:32 INFO - rmtree: /builds/slave/test/build 18:30:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:30:34 INFO - Running post-action listener: _resource_record_post_action 18:30:34 INFO - [mozharness: 2017-03-25 01:30:34.779444Z] Finished clobber step (success) 18:30:34 INFO - [mozharness: 2017-03-25 01:30:34.779569Z] Running read-buildbot-config step. 18:30:34 INFO - Running pre-action listener: _resource_record_pre_action 18:30:34 INFO - Running main action method: read_buildbot_config 18:30:34 INFO - Using buildbot properties: 18:30:34 INFO - { 18:30:34 INFO - "project": "", 18:30:34 INFO - "product": "firefox", 18:30:34 INFO - "script_repo_revision": "production", 18:30:34 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 18:30:34 INFO - "repository": "", 18:30:34 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 18:30:34 INFO - "buildid": "20170324170416", 18:30:34 INFO - "pgo_build": "False", 18:30:34 INFO - "basedir": "/builds/slave/test", 18:30:34 INFO - "buildnumber": 25, 18:30:34 INFO - "slavename": "t-yosemite-r7-0314", 18:30:34 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 18:30:34 INFO - "platform": "yosemite_r7", 18:30:34 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 18:30:34 INFO - "branch": "mozilla-central", 18:30:34 INFO - "repo_path": "mozilla-central", 18:30:34 INFO - "revision": "f9acfdca68a45c8cecf54f5a1bfc3b2a4baa52a3", 18:30:34 INFO - "stage_platform": "macosx64", 18:30:34 INFO - "builduid": "d6b27b42eae74ef4a61ce685b2a505b9", 18:30:34 INFO - "slavebuilddir": "test" 18:30:34 INFO - } 18:30:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/TN3sA-yTSn2eIb8T2ruPxA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 18:30:34 INFO - Running post-action listener: _resource_record_post_action 18:30:34 INFO - [mozharness: 2017-03-25 01:30:34.782714Z] Finished read-buildbot-config step (success) 18:30:34 INFO - [mozharness: 2017-03-25 01:30:34.782837Z] Running download-and-extract step. 18:30:34 INFO - Running pre-action listener: _resource_record_pre_action 18:30:34 INFO - Running main action method: download_and_extract 18:30:34 INFO - mkdir: /builds/slave/test/build/tests 18:30:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:30:34 INFO - trying https://queue.taskcluster.net/v1/task/TN3sA-yTSn2eIb8T2ruPxA/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 18:30:34 INFO - Downloading https://queue.taskcluster.net/v1/task/TN3sA-yTSn2eIb8T2ruPxA/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 18:30:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TN3sA-yTSn2eIb8T2ruPxA/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 18:30:36 INFO - Downloaded 1325 bytes. 18:30:36 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 18:30:36 INFO - Using the following test package requirements: 18:30:36 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 18:30:36 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 18:30:36 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 18:30:36 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 18:30:36 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 18:30:36 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 18:30:36 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 18:30:36 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 18:30:36 INFO - u'jsshell-mac.zip'], 18:30:36 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 18:30:36 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 18:30:36 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 18:30:36 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 18:30:36 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 18:30:36 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 18:30:36 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 18:30:36 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 18:30:36 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 18:30:36 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 18:30:36 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 18:30:36 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 18:30:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TN3sA-yTSn2eIb8T2ruPxA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 18:30:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TN3sA-yTSn2eIb8T2ruPxA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 18:30:36 INFO - Fetch https://queue.taskcluster.net/v1/task/TN3sA-yTSn2eIb8T2ruPxA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 18:30:37 INFO - Expected file size: 52409077 18:30:37 INFO - Obtained file size: 52409077 18:30:54 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 18:30:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TN3sA-yTSn2eIb8T2ruPxA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 18:30:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TN3sA-yTSn2eIb8T2ruPxA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 18:30:54 INFO - Fetch https://queue.taskcluster.net/v1/task/TN3sA-yTSn2eIb8T2ruPxA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 18:30:56 INFO - Expected file size: 52409077 18:30:56 INFO - Obtained file size: 52409077 18:31:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TN3sA-yTSn2eIb8T2ruPxA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 18:31:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TN3sA-yTSn2eIb8T2ruPxA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 18:31:11 INFO - Fetch https://queue.taskcluster.net/v1/task/TN3sA-yTSn2eIb8T2ruPxA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 18:31:12 INFO - Expected file size: 14404171 18:31:12 INFO - Obtained file size: 14404171 18:31:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:31:12 INFO - trying https://queue.taskcluster.net/v1/task/TN3sA-yTSn2eIb8T2ruPxA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 18:31:12 INFO - Downloading https://queue.taskcluster.net/v1/task/TN3sA-yTSn2eIb8T2ruPxA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 18:31:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TN3sA-yTSn2eIb8T2ruPxA/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 18:31:14 INFO - Downloaded 75577133 bytes. 18:31:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TN3sA-yTSn2eIb8T2ruPxA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 18:31:14 INFO - mkdir: /builds/slave/test/properties 18:31:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:31:14 INFO - Writing to file /builds/slave/test/properties/build_url 18:31:14 INFO - Contents: 18:31:14 INFO - build_url:https://queue.taskcluster.net/v1/task/TN3sA-yTSn2eIb8T2ruPxA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 18:31:15 INFO - Running post-action listener: _resource_record_post_action 18:31:15 INFO - Running post-action listener: set_extra_try_arguments 18:31:15 INFO - [mozharness: 2017-03-25 01:31:15.253273Z] Finished download-and-extract step (success) 18:31:15 INFO - [mozharness: 2017-03-25 01:31:15.253425Z] Running populate-webroot step. 18:31:15 INFO - Running pre-action listener: _resource_record_pre_action 18:31:15 INFO - Running main action method: populate_webroot 18:31:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:31:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:31:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:31:15 INFO - '--tppagecycles', 18:31:15 INFO - '7'], 18:31:15 INFO - 'tests': ['tsvgm']}}, 18:31:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:31:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:31:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:31:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:31:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:31:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:31:15 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 18:31:15 INFO - 'talos_options': ['--disable-e10s'], 18:31:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:31:15 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 18:31:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:31:15 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 18:31:15 INFO - 'talos_options': ['--disable-e10s'], 18:31:15 INFO - 'tests': ['damp', 'tps']}, 18:31:15 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 18:31:15 INFO - 'tests': ['damp', 'tps']}, 18:31:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:31:15 INFO - 'tests': ['dromaeo_dom']}, 18:31:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:31:15 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:31:15 INFO - 'tests': ['basic_compositor_video']}, 18:31:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:31:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:31:15 INFO - 'tests': ['a11yr', 18:31:15 INFO - 'ts_paint', 18:31:15 INFO - 'tpaint', 18:31:15 INFO - 'sessionrestore', 18:31:15 INFO - 'sessionrestore_no_auto_restore', 18:31:15 INFO - 'tabpaint']}, 18:31:15 INFO - 'other-e10s': {'tests': ['a11yr', 18:31:15 INFO - 'ts_paint', 18:31:15 INFO - 'tpaint', 18:31:15 INFO - 'sessionrestore', 18:31:15 INFO - 'sessionrestore_no_auto_restore', 18:31:15 INFO - 'tabpaint']}, 18:31:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:31:15 INFO - 'ts_paint', 18:31:15 INFO - 'tpaint', 18:31:15 INFO - 'sessionrestore', 18:31:15 INFO - 'sessionrestore_no_auto_restore', 18:31:15 INFO - 'tabpaint']}, 18:31:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:31:15 INFO - 'ts_paint', 18:31:15 INFO - 'tpaint', 18:31:15 INFO - 'sessionrestore', 18:31:15 INFO - 'sessionrestore_no_auto_restore', 18:31:15 INFO - 'tabpaint']}, 18:31:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:31:15 INFO - 'tests': ['a11yr', 18:31:15 INFO - 'ts_paint', 18:31:15 INFO - 'tpaint', 18:31:15 INFO - 'sessionrestore', 18:31:15 INFO - 'sessionrestore_no_auto_restore', 18:31:15 INFO - 'tabpaint']}, 18:31:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:31:15 INFO - 'tests': ['a11yr', 18:31:15 INFO - 'ts_paint', 18:31:15 INFO - 'tpaint', 18:31:15 INFO - 'sessionrestore', 18:31:15 INFO - 'sessionrestore_no_auto_restore', 18:31:15 INFO - 'tabpaint']}, 18:31:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:31:15 INFO - 'tests': ['tsvgx', 18:31:15 INFO - 'tsvgr_opacity', 18:31:15 INFO - 'tart', 18:31:15 INFO - 'tscrollx', 18:31:15 INFO - 'cart', 18:31:15 INFO - 'tsvg_static']}, 18:31:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:31:15 INFO - 'tsvgr_opacity', 18:31:15 INFO - 'tart', 18:31:15 INFO - 'tscrollx', 18:31:15 INFO - 'cart', 18:31:15 INFO - 'tsvg_static']}, 18:31:15 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 18:31:15 INFO - 'talos_options': ['--disable-e10s'], 18:31:15 INFO - 'tests': ['tp5o']}, 18:31:15 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 18:31:15 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 18:31:15 INFO - 'talos_options': ['--disable-e10s', 18:31:15 INFO - '--xperf_path', 18:31:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:31:15 INFO - 'tests': ['tp5n']}, 18:31:15 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 18:31:15 INFO - 'talos_options': ['--xperf_path', 18:31:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:31:15 INFO - 'tests': ['tp5n']}}, 18:31:15 INFO - 'talos.zip': {'path': '', 18:31:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:31:15 INFO - Running post-action listener: _resource_record_post_action 18:31:15 INFO - [mozharness: 2017-03-25 01:31:15.271880Z] Finished populate-webroot step (success) 18:31:15 INFO - [mozharness: 2017-03-25 01:31:15.271999Z] Running create-virtualenv step. 18:31:15 INFO - Running pre-action listener: _resource_record_pre_action 18:31:15 INFO - Running main action method: create_virtualenv 18:31:15 INFO - Creating virtualenv /builds/slave/test/build/venv 18:31:15 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 18:31:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:31:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:31:15 INFO - Using real prefix '/tools/python27' 18:31:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:31:16 INFO - Installing distribute.............................................................................................................................................................................................done. 18:31:18 INFO - Installing pip.................done. 18:31:19 INFO - Return code: 0 18:31:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:31:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:31:19 INFO - Reading from file tmpfile_stdout 18:31:19 INFO - Output received: 18:31:19 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 18:31:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:31: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')]} 18:31:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31: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')]} 18:31:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:19 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 0x10ca42b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca45768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8c10cd6c10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c820d30>, '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 0x10c747db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c815be8>, '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.cM93edOhS7/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.RcqsQUQwRe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:31:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:31:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:31:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cM93edOhS7/Render', 18:31:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:31:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:31:19 INFO - 'HOME': '/Users/cltbld', 18:31:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:31:19 INFO - 'LOGNAME': 'cltbld', 18:31:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:19 INFO - 'MOZ_NO_REMOTE': '1', 18:31:19 INFO - 'NO_EM_RESTART': '1', 18:31:19 INFO - 'PAGER': '/bin/cat', 18:31:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:31:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:19 INFO - 'PWD': '/builds/slave/test', 18:31:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:31:19 INFO - 'SHELL': '/bin/bash', 18:31:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RcqsQUQwRe/Listeners', 18:31:19 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 18:31:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:31:19 INFO - 'USER': 'cltbld', 18:31:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:31:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:31:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:19 INFO - 'XPC_FLAGS': '0x0', 18:31:19 INFO - 'XPC_SERVICE_NAME': '0', 18:31:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:31:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:19 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 18:31:19 INFO - Cleaning up... 18:31:19 INFO - Return code: 0 18:31:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:31: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')]} 18:31:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31: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')]} 18:31:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:19 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 0x10ca42b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca45768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8c10cd6c10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c820d30>, '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 0x10c747db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c815be8>, '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.cM93edOhS7/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.RcqsQUQwRe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:31:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 18:31:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 18:31:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cM93edOhS7/Render', 18:31:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:31:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:31:19 INFO - 'HOME': '/Users/cltbld', 18:31:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:31:19 INFO - 'LOGNAME': 'cltbld', 18:31:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:19 INFO - 'MOZ_NO_REMOTE': '1', 18:31:19 INFO - 'NO_EM_RESTART': '1', 18:31:19 INFO - 'PAGER': '/bin/cat', 18:31:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:31:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:19 INFO - 'PWD': '/builds/slave/test', 18:31:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:31:19 INFO - 'SHELL': '/bin/bash', 18:31:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RcqsQUQwRe/Listeners', 18:31:19 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 18:31:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:31:19 INFO - 'USER': 'cltbld', 18:31:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:31:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:31:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:19 INFO - 'XPC_FLAGS': '0x0', 18:31:19 INFO - 'XPC_SERVICE_NAME': '0', 18:31:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:31:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:19 INFO - Downloading/unpacking psutil>=3.1.1 18:31:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:31:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:31:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:31:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:31:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:31:23 INFO - Installing collected packages: psutil 18:31:23 INFO - Running setup.py install for psutil 18:31:23 INFO - building 'psutil._psutil_osx' extension 18:31:23 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 18:31:23 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 18:31:23 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 18:31:23 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 18:31:23 INFO - building 'psutil._psutil_posix' extension 18:31:23 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 18:31:24 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 18:31:24 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 18:31:24 INFO - ^ 18:31:24 INFO - 1 warning generated. 18:31:24 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 18:31:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:31:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:31:24 INFO - Successfully installed psutil 18:31:24 INFO - Cleaning up... 18:31:24 INFO - Return code: 0 18:31:24 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:31:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:31:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:31:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:24 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 0x10ca42b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca45768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8c10cd6c10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c820d30>, '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 0x10c747db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c815be8>, '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.cM93edOhS7/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.RcqsQUQwRe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:31:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 18:31:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 18:31:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cM93edOhS7/Render', 18:31:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:31:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:31:24 INFO - 'HOME': '/Users/cltbld', 18:31:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:31:24 INFO - 'LOGNAME': 'cltbld', 18:31:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:24 INFO - 'MOZ_NO_REMOTE': '1', 18:31:24 INFO - 'NO_EM_RESTART': '1', 18:31:24 INFO - 'PAGER': '/bin/cat', 18:31:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:31:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:24 INFO - 'PWD': '/builds/slave/test', 18:31:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:31:24 INFO - 'SHELL': '/bin/bash', 18:31:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RcqsQUQwRe/Listeners', 18:31:24 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 18:31:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:31:24 INFO - 'USER': 'cltbld', 18:31:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:31:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:31:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:24 INFO - 'XPC_FLAGS': '0x0', 18:31:24 INFO - 'XPC_SERVICE_NAME': '0', 18:31:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:31:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:24 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:31:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:31:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:31:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:31:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:31:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:31:27 INFO - Installing collected packages: mozsystemmonitor 18:31:27 INFO - Running setup.py install for mozsystemmonitor 18:31:27 INFO - Successfully installed mozsystemmonitor 18:31:27 INFO - Cleaning up... 18:31:27 INFO - Return code: 0 18:31:27 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:31:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:31:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:31:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10ca42b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca45768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8c10cd6c10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c820d30>, '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 0x10c747db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c815be8>, '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.cM93edOhS7/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.RcqsQUQwRe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:31:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 18:31:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 18:31:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cM93edOhS7/Render', 18:31:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:31:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:31:28 INFO - 'HOME': '/Users/cltbld', 18:31:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:31:28 INFO - 'LOGNAME': 'cltbld', 18:31:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:28 INFO - 'MOZ_NO_REMOTE': '1', 18:31:28 INFO - 'NO_EM_RESTART': '1', 18:31:28 INFO - 'PAGER': '/bin/cat', 18:31:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:31:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:28 INFO - 'PWD': '/builds/slave/test', 18:31:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:31:28 INFO - 'SHELL': '/bin/bash', 18:31:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RcqsQUQwRe/Listeners', 18:31:28 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 18:31:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:31:28 INFO - 'USER': 'cltbld', 18:31:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:31:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:31:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:28 INFO - 'XPC_FLAGS': '0x0', 18:31:28 INFO - 'XPC_SERVICE_NAME': '0', 18:31:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:31:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:28 INFO - Downloading/unpacking jsonschema==2.5.1 18:31:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:31:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:31:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:31:31 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:31:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:31:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:31:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:31 INFO - Downloading functools32-3.2.3-2.tar.gz 18:31:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:31:31 INFO - warning: no files found matching '*.txt' 18:31:31 INFO - no previously-included directories found matching 'build' 18:31:31 INFO - no previously-included directories found matching 'dist' 18:31:31 INFO - no previously-included directories found matching '.git*' 18:31:31 INFO - Installing collected packages: jsonschema, functools32 18:31:32 INFO - Running setup.py install for functools32 18:31:32 INFO - warning: no files found matching '*.txt' 18:31:32 INFO - no previously-included directories found matching 'build' 18:31:32 INFO - no previously-included directories found matching 'dist' 18:31:32 INFO - no previously-included directories found matching '.git*' 18:31:32 INFO - Successfully installed jsonschema functools32 18:31:32 INFO - Cleaning up... 18:31:32 INFO - Return code: 0 18:31:32 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:31:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:31:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:31:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:32 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 0x10ca42b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca45768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8c10cd6c10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c820d30>, '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 0x10c747db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c815be8>, '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.cM93edOhS7/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.RcqsQUQwRe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:31:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 18:31:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 18:31:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cM93edOhS7/Render', 18:31:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:31:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:31:32 INFO - 'HOME': '/Users/cltbld', 18:31:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:31:32 INFO - 'LOGNAME': 'cltbld', 18:31:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:32 INFO - 'MOZ_NO_REMOTE': '1', 18:31:32 INFO - 'NO_EM_RESTART': '1', 18:31:32 INFO - 'PAGER': '/bin/cat', 18:31:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:31:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:32 INFO - 'PWD': '/builds/slave/test', 18:31:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:31:32 INFO - 'SHELL': '/bin/bash', 18:31:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RcqsQUQwRe/Listeners', 18:31:32 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 18:31:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:31:32 INFO - 'USER': 'cltbld', 18:31:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:31:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:31:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:32 INFO - 'XPC_FLAGS': '0x0', 18:31:32 INFO - 'XPC_SERVICE_NAME': '0', 18:31:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:31:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:32 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:31:32 INFO - Cleaning up... 18:31:32 INFO - Return code: 0 18:31:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:31:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:31:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:31:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:32 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 0x10ca42b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca45768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8c10cd6c10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c820d30>, '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 0x10c747db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c815be8>, '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.cM93edOhS7/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.RcqsQUQwRe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:31:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:31:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:31:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cM93edOhS7/Render', 18:31:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:31:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:31:32 INFO - 'HOME': '/Users/cltbld', 18:31:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:31:32 INFO - 'LOGNAME': 'cltbld', 18:31:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:32 INFO - 'MOZ_NO_REMOTE': '1', 18:31:32 INFO - 'NO_EM_RESTART': '1', 18:31:32 INFO - 'PAGER': '/bin/cat', 18:31:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:31:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:32 INFO - 'PWD': '/builds/slave/test', 18:31:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:31:32 INFO - 'SHELL': '/bin/bash', 18:31:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RcqsQUQwRe/Listeners', 18:31:32 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 18:31:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:31:32 INFO - 'USER': 'cltbld', 18:31:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:31:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:31:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:32 INFO - 'XPC_FLAGS': '0x0', 18:31:32 INFO - 'XPC_SERVICE_NAME': '0', 18:31:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:31:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:32 INFO - Downloading/unpacking blobuploader==1.2.4 18:31:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:31:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:31:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:35 INFO - Downloading blobuploader-1.2.4.tar.gz 18:31:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:31:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:31:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:31:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:31:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:31:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:31:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:31:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:31:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:36 INFO - Downloading docopt-0.6.1.tar.gz 18:31:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:31:36 INFO - Installing collected packages: blobuploader, requests, docopt 18:31:36 INFO - Running setup.py install for blobuploader 18:31:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:31:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:31:36 INFO - Running setup.py install for requests 18:31:37 INFO - Running setup.py install for docopt 18:31:37 INFO - Successfully installed blobuploader requests docopt 18:31:37 INFO - Cleaning up... 18:31:37 INFO - Return code: 0 18:31:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:31:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:31:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:31:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:37 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 0x10ca42b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca45768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8c10cd6c10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c820d30>, '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 0x10c747db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c815be8>, '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.cM93edOhS7/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.RcqsQUQwRe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:31:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:31:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:31:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cM93edOhS7/Render', 18:31:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:31:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:31:37 INFO - 'HOME': '/Users/cltbld', 18:31:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:31:37 INFO - 'LOGNAME': 'cltbld', 18:31:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:37 INFO - 'MOZ_NO_REMOTE': '1', 18:31:37 INFO - 'NO_EM_RESTART': '1', 18:31:37 INFO - 'PAGER': '/bin/cat', 18:31:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:31:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:37 INFO - 'PWD': '/builds/slave/test', 18:31:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:31:37 INFO - 'SHELL': '/bin/bash', 18:31:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RcqsQUQwRe/Listeners', 18:31:37 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 18:31:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:31:37 INFO - 'USER': 'cltbld', 18:31:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:31:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:31:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:37 INFO - 'XPC_FLAGS': '0x0', 18:31:37 INFO - 'XPC_SERVICE_NAME': '0', 18:31:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:31:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:31:37 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-n0JfCw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:31:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:31:38 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-MJ9LCo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:31:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:31:38 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-_oWHnk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:31:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:31:38 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-AnhSKg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:31:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:31:38 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-ziFsJj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:31:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:31:38 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-IYYeXt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:31:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:31:38 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-Vrpvic-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:31:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:31:38 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-OA9mxV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:31:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:31:38 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-CqlHTx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:31:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:31:38 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-8fJB0n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:31:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:31:38 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-mbCpLx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:31:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:31:39 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-p6avn1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:31:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:31:39 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-TMSTb5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:31:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:31:39 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-oKTNJ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:31:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:31:39 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-vdKqH6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:31:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:31:39 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-CWLBlQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:31:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:31:39 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-yglZhA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:31:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:31:39 INFO - Running setup.py install for manifestparser 18:31:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:31:39 INFO - Running setup.py install for mozcrash 18:31:39 INFO - Running setup.py install for mozdebug 18:31:40 INFO - Running setup.py install for mozdevice 18:31:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:31:40 INFO - Running setup.py install for mozfile 18:31:40 INFO - Running setup.py install for mozhttpd 18:31:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:31:40 INFO - Running setup.py install for mozinfo 18:31:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:31:40 INFO - Running setup.py install for mozInstall 18:31:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:31:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:31:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:31:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:31:40 INFO - Running setup.py install for mozleak 18:31:40 INFO - Running setup.py install for mozlog 18:31:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:31:41 INFO - Running setup.py install for moznetwork 18:31:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:31:41 INFO - Running setup.py install for mozprocess 18:31:41 INFO - Running setup.py install for mozprofile 18:31:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:31:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:31:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:31:41 INFO - Running setup.py install for mozrunner 18:31:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:31:41 INFO - Running setup.py install for mozscreenshot 18:31:41 INFO - Running setup.py install for moztest 18:31:42 INFO - Running setup.py install for mozversion 18:31:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:31:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:31:42 INFO - Cleaning up... 18:31:42 INFO - Return code: 0 18:31:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:31:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:31:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:31:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:42 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 0x10ca42b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca45768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8c10cd6c10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c820d30>, '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 0x10c747db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c815be8>, '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.cM93edOhS7/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.RcqsQUQwRe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:31:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:31:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:31:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cM93edOhS7/Render', 18:31:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:31:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:31:42 INFO - 'HOME': '/Users/cltbld', 18:31:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:31:42 INFO - 'LOGNAME': 'cltbld', 18:31:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:42 INFO - 'MOZ_NO_REMOTE': '1', 18:31:42 INFO - 'NO_EM_RESTART': '1', 18:31:42 INFO - 'PAGER': '/bin/cat', 18:31:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:31:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:42 INFO - 'PWD': '/builds/slave/test', 18:31:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:31:42 INFO - 'SHELL': '/bin/bash', 18:31:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RcqsQUQwRe/Listeners', 18:31:42 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 18:31:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:31:42 INFO - 'USER': 'cltbld', 18:31:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:31:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:31:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:42 INFO - 'XPC_FLAGS': '0x0', 18:31:42 INFO - 'XPC_SERVICE_NAME': '0', 18:31:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:31:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:31:42 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-04sxYX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:31:42 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 18:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:31:42 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-UMOq3y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:31:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:31:42 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-slTOH3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:31:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:31:42 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-sVeUP6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:31:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:31:42 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-bhe8zk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:31:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 18:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:31:43 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-1yrdCk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:31:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 18:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:31:43 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-S2ZtWh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:31:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 18:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:31:43 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-nSL7PL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:31:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 18:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:31:43 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-PoNTbJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:31:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 18:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:31:43 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-EaFt76-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:31:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:31:43 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-owbQ3O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:31:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 18:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:31:43 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-MbbkZy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:31:43 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)) 18:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:31:43 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-FJeZyC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:31:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 18:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:31:43 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-CvEaTG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:31:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 18:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:31:44 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-LU6C2b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:31:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 18:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:31:44 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-v6JfeI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:31:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 18:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:31:44 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-eEGP_l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:31:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 18:31:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:31:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:31:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:31:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:31:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:31:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:31:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:31:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:31:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:46 INFO - Downloading blessings-1.6.tar.gz 18:31:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:31:47 INFO - Installing collected packages: blessings 18:31:47 INFO - Running setup.py install for blessings 18:31:47 INFO - Successfully installed blessings 18:31:47 INFO - Cleaning up... 18:31:47 INFO - Return code: 0 18:31:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:31:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:31:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:31:47 INFO - Reading from file tmpfile_stdout 18:31:47 INFO - Current package versions: 18:31:47 INFO - blessings == 1.6 18:31:47 INFO - blobuploader == 1.2.4 18:31:47 INFO - docopt == 0.6.1 18:31:47 INFO - functools32 == 3.2.3-2 18:31:47 INFO - jsonschema == 2.5.1 18:31:47 INFO - manifestparser == 1.1 18:31:47 INFO - mozInstall == 1.12 18:31:47 INFO - mozcrash == 1.0 18:31:47 INFO - mozdebug == 0.1 18:31:47 INFO - mozdevice == 0.49 18:31:47 INFO - mozfile == 1.2 18:31:47 INFO - mozhttpd == 0.7 18:31:47 INFO - mozinfo == 0.9 18:31:47 INFO - mozleak == 0.1 18:31:47 INFO - mozlog == 3.4 18:31:47 INFO - moznetwork == 0.27 18:31:47 INFO - mozprocess == 0.25 18:31:47 INFO - mozprofile == 0.28 18:31:47 INFO - mozrunner == 6.13 18:31:47 INFO - mozscreenshot == 0.1 18:31:47 INFO - mozsystemmonitor == 0.3 18:31:47 INFO - moztest == 0.8 18:31:47 INFO - mozversion == 1.4 18:31:47 INFO - psutil == 3.1.1 18:31:47 INFO - requests == 1.2.3 18:31:47 INFO - wsgiref == 0.1.2 18:31:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:31:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:31:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:31:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:47 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 0x10ca42b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca45768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8c10cd6c10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c820d30>, '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 0x10c747db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c815be8>, '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.cM93edOhS7/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.RcqsQUQwRe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:31:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 18:31:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:31:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cM93edOhS7/Render', 18:31:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:31:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:31:47 INFO - 'HOME': '/Users/cltbld', 18:31:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:31:47 INFO - 'LOGNAME': 'cltbld', 18:31:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:47 INFO - 'MOZ_NO_REMOTE': '1', 18:31:47 INFO - 'NO_EM_RESTART': '1', 18:31:47 INFO - 'PAGER': '/bin/cat', 18:31:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:31:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:47 INFO - 'PWD': '/builds/slave/test', 18:31:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:31:47 INFO - 'SHELL': '/bin/bash', 18:31:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RcqsQUQwRe/Listeners', 18:31:47 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 18:31:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:31:47 INFO - 'USER': 'cltbld', 18:31:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:31:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:31:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:47 INFO - 'XPC_FLAGS': '0x0', 18:31:47 INFO - 'XPC_SERVICE_NAME': '0', 18:31:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:31:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:31:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 18:31:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 18:31:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:31:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 18:31:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 18:31:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 18:31:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 18:31:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 18:31:47 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:31:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:31:47 INFO - Cleaning up... 18:31:47 INFO - Return code: 0 18:31:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:31:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:31:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:31:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:47 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 0x10ca42b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca45768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8c10cd6c10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c820d30>, '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 0x10c747db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c815be8>, '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.cM93edOhS7/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.RcqsQUQwRe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:31:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:31:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:31:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cM93edOhS7/Render', 18:31:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:31:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:31:47 INFO - 'HOME': '/Users/cltbld', 18:31:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:31:47 INFO - 'LOGNAME': 'cltbld', 18:31:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:47 INFO - 'MOZ_NO_REMOTE': '1', 18:31:47 INFO - 'NO_EM_RESTART': '1', 18:31:47 INFO - 'PAGER': '/bin/cat', 18:31:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:31:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:47 INFO - 'PWD': '/builds/slave/test', 18:31:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:31:47 INFO - 'SHELL': '/bin/bash', 18:31:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RcqsQUQwRe/Listeners', 18:31:47 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 18:31:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:31:47 INFO - 'USER': 'cltbld', 18:31:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:31:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:31:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:47 INFO - 'XPC_FLAGS': '0x0', 18:31:47 INFO - 'XPC_SERVICE_NAME': '0', 18:31:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:31:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:31:48 INFO - Cleaning up... 18:31:48 INFO - Return code: 0 18:31:48 INFO - Running post-action listener: _resource_record_post_action 18:31:48 INFO - Running post-action listener: _start_resource_monitoring 18:31:48 INFO - Starting resource monitoring. 18:31:48 INFO - [mozharness: 2017-03-25 01:31:48.148611Z] Finished create-virtualenv step (success) 18:31:48 INFO - [mozharness: 2017-03-25 01:31:48.149596Z] Running install step. 18:31:48 INFO - Running pre-action listener: _resource_record_pre_action 18:31:48 INFO - Running main action method: install 18:31:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:31:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:31:48 INFO - Reading from file tmpfile_stdout 18:31:48 INFO - Detecting whether we're running mozinstall >=1.0... 18:31:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:31:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:31:48 INFO - Reading from file tmpfile_stdout 18:31:48 INFO - Output received: 18:31:48 INFO - Usage: mozinstall [options] installer 18:31:48 INFO - Options: 18:31:48 INFO - -h, --help show this help message and exit 18:31:48 INFO - -d DEST, --destination=DEST 18:31:48 INFO - Directory to install application into. [default: 18:31:48 INFO - "/builds/slave/test"] 18:31:48 INFO - --app=APP Application being installed. [default: firefox] 18:31:48 INFO - mkdir: /builds/slave/test/build/application 18:31:48 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'] 18:31:48 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 18:32:08 INFO - Reading from file tmpfile_stdout 18:32:08 INFO - Output received: 18:32:08 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 18:32:08 INFO - Running post-action listener: _resource_record_post_action 18:32:08 INFO - [mozharness: 2017-03-25 01:32:08.763362Z] Finished install step (success) 18:32:08 INFO - [mozharness: 2017-03-25 01:32:08.763493Z] Running run-tests step. 18:32:08 INFO - Running pre-action listener: _resource_record_pre_action 18:32:08 INFO - Running main action method: run_tests 18:32:08 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:32:08 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:32:08 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:32:08 INFO - 2017-03-24 18:32:08.778 screenresolution[2052:14500] starting screenresolution argv=screenresolution get 18:32:08 INFO - 2017-03-24 18:32:08.781 screenresolution[2052:14500] Display 0: 1600x1200x32@60 18:32:08 INFO - 2017-03-24 18:32:08.787 screenresolution[2053:14502] starting screenresolution argv=screenresolution list 18:32:08 INFO - Available Modes on Display 0 18:32:08 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:32:08 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:32:08 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:32:08 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:32:09 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:32:09 INFO - Intel Iris: 18:32:09 INFO - Chipset Model: Intel Iris 18:32:09 INFO - Type: GPU 18:32:09 INFO - Bus: Built-In 18:32:09 INFO - VRAM (Dynamic, Max): 1536 MB 18:32:09 INFO - Vendor: Intel (0x8086) 18:32:09 INFO - Device ID: 0x0a2e 18:32:09 INFO - Revision ID: 0x0009 18:32:09 INFO - Displays: 18:32:09 INFO - Display: 18:32:09 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:32:09 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:32:09 INFO - Display Serial Number: 1600x1200 60 18:32:09 INFO - Main Display: Yes 18:32:09 INFO - Mirror: Off 18:32:09 INFO - Online: Yes 18:32:09 INFO - Rotation: Supported 18:32:09 INFO - Return code: 0 18:32:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:32:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:32:09 INFO - Python 2.7.3 18:32:09 INFO - Return code: 0 18:32:09 INFO - grabbing minidump binary from tooltool 18:32:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:32:09 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 0x10c820d30>, '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 0x10c747db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c815be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:32:09 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 18:32:09 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 18:32:09 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 18:32:09 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:32:09 INFO - Return code: 0 18:32:09 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 18:32:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:32:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:32:09 INFO - ENV: RUST_BACKTRACE is now 1 18:32:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 18:32:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:32:09 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/TN3sA-yTSn2eIb8T2ruPxA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0314', '--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 18:32:09 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/TN3sA-yTSn2eIb8T2ruPxA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0314 --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 18:32:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cM93edOhS7/Render', 18:32:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:32:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:32:09 INFO - 'HOME': '/Users/cltbld', 18:32:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:32:09 INFO - 'LOGNAME': 'cltbld', 18:32:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:32:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 18:32:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:32:09 INFO - 'MOZ_NO_REMOTE': '1', 18:32:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:32:09 INFO - 'NO_EM_RESTART': '1', 18:32:09 INFO - 'PAGER': '/bin/cat', 18:32:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:32:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:32:09 INFO - 'PWD': '/builds/slave/test', 18:32:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:32:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:32:09 INFO - 'RUST_BACKTRACE': '1', 18:32:09 INFO - 'SHELL': '/bin/bash', 18:32:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RcqsQUQwRe/Listeners', 18:32:09 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 18:32:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:32:09 INFO - 'USER': 'cltbld', 18:32:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:32:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:32:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:32:09 INFO - 'XPC_FLAGS': '0x0', 18:32:09 INFO - 'XPC_SERVICE_NAME': '0', 18:32:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:32:09 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/TN3sA-yTSn2eIb8T2ruPxA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0314', '--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 18:32:09 INFO - mozversion application_buildid: 20170324170416 18:32:09 INFO - mozversion application_changeset: f9acfdca68a45c8cecf54f5a1bfc3b2a4baa52a3 18:32:09 INFO - mozversion application_display_name: Nightly 18:32:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:32:09 INFO - mozversion application_name: Firefox 18:32:09 INFO - mozversion application_remotingname: firefox 18:32:09 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:32:09 INFO - mozversion application_vendor: Mozilla 18:32:09 INFO - mozversion application_version: 55.0a1 18:32:09 INFO - mozversion platform_buildid: 20170324170416 18:32:09 INFO - mozversion platform_changeset: f9acfdca68a45c8cecf54f5a1bfc3b2a4baa52a3 18:32:09 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:32:09 INFO - mozversion platform_version: 55.0a1 18:32:09 INFO - using testdate: 1490405529 18:32:09 INFO - actual date: 1490405529 18:32:09 INFO - starting webserver on 'localhost:52063' 18:32:09 INFO - SUITE-START | Running 2 tests 18:32:09 INFO - TEST-START | dromaeo_css 18:32:09 INFO - operating with platform_type : mac_ 18:32:09 INFO - Initialising browser for dromaeo_css test... 18:32:09 INFO - TEST-INFO | started process 2063 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/tmpJuOG9h/profile http://localhost:52063/getInfo.html) 18:32:12 INFO - PID 2063 | 2017-03-24 18:32:12.426 plugin-container[2066:14673] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d3f, name = 'com.apple.tsm.portname' 18:32:12 INFO - PID 2063 | See /usr/include/servers/bootstrap_defs.h for the error codes. 18:32:12 INFO - PID 2063 | 2017-03-24 18:32:12.431 plugin-container[2066:14673] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4b1f, name = 'com.apple.CFPasteboardClient' 18:32:12 INFO - PID 2063 | See /usr/include/servers/bootstrap_defs.h for the error codes. 18:32:12 INFO - PID 2063 | 2017-03-24 18:32:12.431 plugin-container[2066:14673] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 18:32:12 INFO - PID 2063 | __metrics Screen width/height:1600/1200 18:32:12 INFO - PID 2063 | colorDepth:24 18:32:12 INFO - PID 2063 | Browser inner width/height: 1024/689 18:32:12 INFO - PID 2063 | __metrics 18:32:12 ERROR - PID 2063 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3392: TypeError: this.tabs is undefined 18:32:13 INFO - TEST-INFO | 2063: exit 0 18:32:13 INFO - Browser initialized. 18:32:13 INFO - Running cycle 1/1 for dromaeo_css test... 18:32:13 INFO - TEST-INFO | started process 2067 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/tmpJuOG9h/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:32:15 INFO - PID 2067 | 2017-03-24 18:32:15.959 plugin-container[2068:14796] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8833, name = 'com.apple.tsm.portname' 18:32:15 INFO - PID 2067 | See /usr/include/servers/bootstrap_defs.h for the error codes. 18:32:15 INFO - PID 2067 | 2017-03-24 18:32:15.959 plugin-container[2068:14796] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c27, name = 'com.apple.CFPasteboardClient' 18:32:15 INFO - PID 2067 | See /usr/include/servers/bootstrap_defs.h for the error codes. 18:32:15 INFO - PID 2067 | 2017-03-24 18:32:15.959 plugin-container[2068:14796] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 18:32:25 INFO - PID 2067 | RSS: Main: 229396480 18:32:25 INFO - PID 2067 | 18:35:29 INFO - PID 2067 | Cycle 1(1): loaded http://localhost:52063/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52063/tests/dromaeo/cssquery-ext.html) 18:35:31 INFO - PID 2067 | RSS: Main: 255078400 18:35:31 INFO - PID 2067 | 18:37:13 INFO - PID 2067 | ************************* 18:37:13 INFO - PID 2067 | A coding exception was thrown and uncaught in a Task. 18:37:13 INFO - PID 2067 | 18:37:13 ERROR - PID 2067 | Full message: TypeError: NetworkError when attempting to fetch resource. 18:37:13 INFO - PID 2067 | Full stack: 18:37:13 INFO - PID 2067 | ************************* 18:38:33 INFO - PID 2067 | Cycle 1(1): loaded http://localhost:52063/tests/dromaeo/cssquery-ext.html (next: http://localhost:52063/tests/dromaeo/cssquery-jquery.html) 18:38:34 INFO - PID 2067 | RSS: Main: 261980160 18:38:34 INFO - PID 2067 | 18:41:36 INFO - PID 2067 | Cycle 1(1): loaded http://localhost:52063/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52063/tests/dromaeo/cssquery-mootools.html) 18:41:36 INFO - PID 2067 | RSS: Main: 273989632 18:41:36 INFO - PID 2067 | 18:44:38 INFO - PID 2067 | Cycle 1(1): loaded http://localhost:52063/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52063/tests/dromaeo/cssquery-prototype.html) 18:44:39 INFO - PID 2067 | RSS: Main: 266694656 18:44:39 INFO - PID 2067 | 18:47:42 INFO - PID 2067 | Cycle 1(1): loaded http://localhost:52063/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52063/tests/dromaeo/cssquery-yui.html) 18:47:42 INFO - PID 2067 | RSS: Main: 276451328 18:47:42 INFO - PID 2067 | 18:50:46 INFO - PID 2067 | Cycle 1(1): loaded http://localhost:52063/tests/dromaeo/cssquery-yui.html (next: http://localhost:52063/tests/dromaeo/cssquery-dojo.html) 18:50:46 INFO - PID 2067 | RSS: Main: 270598144 18:50:46 INFO - PID 2067 | 18:50:46 INFO - PID 2067 | __start_tp_report 18:50:46 INFO - PID 2067 | _x_x_mozilla_page_load 18:50:46 INFO - PID 2067 | _x_x_mozilla_page_load_details 18:50:46 INFO - PID 2067 | |i|pagename|runs| 18:50:46 INFO - PID 2067 | |0;dojo.html;3538.5930617978925;3552.8756493522733;3559.0568499347673;3602.675759181673;3611.78329300242;5839.240898683176;5887.4406931341455;5940.663350746086;5994.58037937344;6099.7865074722395;6102.938970610293;6157.722902469389;6175.197224360838;6193.721282542285;6246.812595622138;5101.6683915545555;5685.147227915804;5764.193012978187;5789.2763404574425;5900.409959004108;5652.971735141318;5742.196092547047;5847.853803654922;5855.121731740231;5905.763769449239;5591.245181900432;5808.332041815203;5842.941570584325;5880;5901.734421951001;4481.305397663367;5712.514436272922;5784.1902133701315;5791.333996590404;5820.3888591698105;5674.3190817101795;5679.375268720438;5694.629849059798;5740.799072032459;5776.8844623107725;4928.654994150411;6114.814446323758;6117.938820611826;6120.846978825521;6201.782937597162;6598.175228096488;6625.966870165618;6648.800535983928;6673.899891501631;6679.398854103106;6770.221424536192;6776.864462710768;6789.490788190906;6793.388595026422;6797.5581587196675;6147.754089836446;6254.6872656366995;6262.87474250517;6267.843303917347;6271.937280627227;6644.435223006002;6796.286389929085;6864.141982252218;6902.447804175654;6906.516543841984;6309.33751956038;6396.776112836028;6459.354064593503;6545.574537655038;6552.4102830744505;6530.053142294436;6538.346165383518;6588.769393071316;6718.361755633305;6786.3892249697765;6632.568883022588;6646.302138275508;6656.767013154613;6670.332966703388;6670.833229169212;6364.109024736541;6474.093626892239;6479.028145778171;6535.5425120241125;6674.399304062657;5305.257263983045;5352.892942141136;5361.946380536223;5376.139817629239;5378.058839703114;4186.727862688916;4701.48283688794;4729.976350118227;4735.905281894343;4744.430668319824;6190.597611155261;6247.75008999644;6314.431701146918;6320.146780184617;6341.587796793194;5718.656880587178;6673.998900165014;6681.832954176088;6736.797896063126;6741.932580674229;6289.591176573508;6290.654014029273;6319.273283572356;6348.492120630339;6352.936470635327;5796.942030579725;5973.044312909914;5975.820725378246;6003.159557661931;6009.609375390585;6658.96670516654;6786.083878676315;6821.454283657196;6859.931400686129;6881.346272104142;6792.117024786746;6792.694328755317;6808.421284190701;6812.693428795816;6832.726690932307;6472.967635161794;6824.965875170791;6851.3491218334175;6881.587104773729;6888.793336199922;5536.889262214814;6444.420002199825;6545.967270163619;6606.966965165144;6677.699503522256;5834.445727655866;6718.193816742022;6731.730730770714;6738.561993470409;6744.831379215559;6185.2886918003205;6322.589031712924;6465.2564955030775;6467.159269294962;6474.935250647433;6303.149074874833;6380.93619063822;6436.9034464484;6451;6487.416132548094;6250.468710159687;6259.311475737574;6340.651264180515;6350.333215012542;6366.586171898997;6403.135576697086;6458.095866578588;6487.18910136233;6493.188351456068;6494.155759751202;5706.258186435737;5848.766049357978;6198.938010619836;6219.813405597839;6235.3452887446165 18:50:46 INFO - PID 2067 | |1;ext.html;731.73657483306;804.5092493578916;825.3809642767926;1173.425021739348;1281.7756892543803;37039.62960370396;37677.24645507088;37783.62216377835;37830.999999999935;37915.431268530956;36715;37139.442908356395;37191;37239;37244;7951.244631760002;8141.1858814118705;8298.419110662226;8515.105913879046;8536.103709110546;8481.109483504235;8596;8598.957005214965;8605.612747426381;8610;8558;8594.613242404106;8616.224539791418;8621.267192288664;8630.827383452359;7677.232276772306;8066.516009039477;8581.957090214572;8602.18279263469;8644.308455323622;8374.539400332978;8479.915200847974;8556.01605815333;8561.914380856237;8579.270761985239;37697.86906392813;37977;38025.61974380248;38049.42925856114;38171;2631.5000149971634;2989.671136175019;3019.607451031352;3026.8940587079346;3034.908952731422;27286.04498842531;27570.17289481319;27657.723422765917;27716.168514944584;28363.716362836312;2780.6107144999714;2783.151138902634;2792.46943080814;2798.5802129680505;2829.9434011319863;232556;245377.7731111333;248406.757966209;299479;303520.4823975888;45419.31871021937;45443.772781135885;45534.31698524525;45679.77160114178;45769.31346029812;47090.5290947093;47106.528934710215;47122.58632241038;47230.76384618055;47282.52717472781;14174.220417877115;14216.573502794932;14290.857091429161;14327.426902923766;14372.712545749026;11908.821367679491;11938.462769175409;11942.104342174373;11956.744541823156;11967.40162991847;13569.728605427836;13601.727965440636;13633.386497607631;13651.658708532168;13729.244891530861;5939.821805345847;5973.940260597338;5996.310424301174;5998.220231369981;6003.969980150158;948.6964171465203;969.2391472693902;974.8837580969891;980.7499087732582;1023.4319952426326;23536.114831770356;28739.425211495654;28806.567901481496;29631.555526667118;30389.936352227567;994.393420013791;1048.6696690542456;1077.6798421933227;1084.1976937066513;1099.1866019145775;11892.940535297268;12287.75424491523;12842.871571284355;14603.707925841423;15278.643716113995;358671;388320;421327;456532.7173364178;459350;56789.43210567924;56856.86286274334;57008;57136.14295785566;57446.712766436736;1417.376354404059;1468.566772802026;1472.0799500312091;1472.3153733513752;1483.1027228526586;27533.724662753917;28171.71828281773;28554.85722571374;28858.42283154283;28859.711402886544;31754;34438.48342274918;36952.07619809526;38094.61905380911;38366;435460;435686;436151;437922.810385946;438321;31631.683683163796;33569.99290021303;34521.30957380889;34586.65413345935;34788.130296742784;34759.82620086883;41337.379939301536;41461;41556.792216038724;44278.89302767457;23996.782154864235;28460.573091403232;30513.54229686601;30533.54199687051;30540;29562.852185738935;30186.396272073995;30344.937927172443;30450.695493044786;30497.39005219839;34959.825200873835;35676.64323356733;36338.63661363458;36458.453123203704;36556.81721591375;26052.609210861472;27391.726082739715;30697.386052278383;30956;30984.0704778857;22772.886135569217;23832.880835596403;24109.397265068514;24308.87845560761;24911.128110516045 18:50:46 INFO - PID 2067 | |2;jquery.html;422.99577004229957;430.4167852559783;437.1682205469064;445.87961250462376;462.8333799832062;19009.429717108473;20834.479138021557;21380.4654883628;21534.353969380903;21608.13567457302;21701.45746356338;22613.095476180933;23343.299701008953;23365.415864603394;23659.76340236597;6060.787872424466;6184.659843708594;6248.937510624904;6266.091416744569;6279.623222606659;5969.522438204955;6170.660613666247;6181.6600086995195;6237.688115594202;6246.812595622138;5973.492253158487;6093.146959425684;6164.075388691687;6191.566590338678;6227.688615569226;6112.69436528174;6156.984097623865;6172.537059720539;6173.783917562886;6176.289726681399;5400.000999815047;5421.783128674848;5495.807646732385;5498.367687715924;5504.504594586507;27073.781679824457;27255.45489090207;27387.45225095507;27416.862915685495;27842;1644.5806319388598;1994.6509360861792;2011.6119877284627;2060.5054786851197;2114.925977590792;16075.115868627221;16725.6654866902;16748.58128546784;16748.748768768477;17409.390671326568;1583.8812089093249;1663.251536808429;1685.6628674265196;1715.3567412220418;1741.364401993276;143012;153303;158550;162281.3771862278;163341.3665863338;12764.93617531925;12933.676658083623;12963;13116.606501804961;13155;16441;16634.916825415796;16642.084685342423;16659.83340166607;16671;6675.965225390072;8741.825163496695;8994.910050899407;9198.724038278862;9212.53937303132;7134;8621.69824056155;8709.346798990102;8781.20969112783;8893.555322233862;6569.67151642416;7815.140334563193;7907.169747176578;7965.402594805413;7966.362690984707;2004.1883037369596;2131.048497830485;2162.3945295317335;2165.242165242184;2354.3525530479255;884.5533005832142;908.7728067983004;922.3359181389388;950.5722424908819;975.6682727872558;20493.692594611093;21071.68392474114;21111.894440528005;21132.683009754866;21158.365249042552;904.9321300902327;963.3545524498603;976.9560369783377;990.3810118675827;997.4464172384396;10774.892251077546;11028;11059.889401105886;11069.50187241576;11075.280106793032;603834;624559;626351;640351;655512;101542.93828246788;108177;146986;160158;160252;972.8881178664402;1179.504608064615;1226.791445454275;1241.422738426636;1246.1028059796931;21183.576328473653;21316.893415533443;21351.78648213498;21417.571648567253;21462.57074858463;56541.15188272262;57166.142507863246;57849;61591.38408615856;62002.689986549776;89478.55260723655;89816;89834.55082724545;90269;90425.40958608921;7122.893156602551;7734.690612375442;7988.92011079905;8353.707620233263;8479.660813567634;11559.76880462403;12379.319137447526;12910.741785164431;13508.729825403634;13527.661808454473;9586.712398627773;10845.24083314192;11176;11183.552657893919;11370.658880233606;9622.749042624415;10161.796764064826;10179.338343007978;10441.738956526147;10546.367217966947;10718.464076795974;11063.059639930374;11697.415129243675;11990.880091199326;11991.400429978292;8466.365022623451;8555.57222138903;8638.17937295956;8726.607302671522;8749.825003500022;11410.801865804304;11488;11656.766864662828;11670.066394688574;11773.646790596296 18:50:46 INFO - PID 2067 | |3;mootools.html;1341.476824038625;1373.478078330235;1382.4746596293407;1393.477445957766;1418.5106138382257;10565.524551395196;10897.291676041072;11043.558257669694;11054.839241879607;11207.271527350737;10795.730106747335;11031.72420689481;11199.832002519948;11216.270942388759;11241.044511216556;2438.451348446599;2487.701475822904;2490.414752533153;2499.2252401755513;2499.562576549106;2355.7408685044716;2406.614941609343;2454.6686197363397;2460.2496238647204;2462.249014050714;2419.721732000825;2422.697162854643;2441.060191826142;2454.4968281502247;2466.7656572625574;2364.775346342095;2426.3448868805413;2437.768412000857;2440.804735621146;2458.053649344997;2347.471818840764;2430.9270721878197;2439.9756002439926;2458.0045081741923;2460.741622129686;11139.275947063416;11211.047060999825;11212.215144939857;11229.60696375631;11240.988311052044;6264.21697287839;6495.447886929616;6501.447376972963;6519.902201466982;6522.445592124675;4043.6158564936286;4080.285949958775;4081.8571350002608;4113.197926404352;4179.017930786263;1115.6597237842454;1133.7732453509332;1197.263682835059;1242.2484396939813;1247.070932155541;13872.93063534686;14330.64173395663;15415.22923853814;15552.377904883904;15565.688686226325;5641.153826925994;5687.402822703557;5919.1713160157615;5950.8809823803285;5976.701164941823;12583.182093163916;12599.811002834966;12626.989840812714;12668.36658167088;12695.04787140968;6351;6404.167458230493;6415.26224484181;6417.550771446047;6419.390157934989;5642.210090587321;5755.769769209269;5836.241288632451;5849.6782676952325;5911.615744976562;4451.888702782457;4484.2376795944765;4503.8606661835365;4537.500874903758;4541.772911354419;1386.5077897346296;1414.4907833180048;1418.659521714781;1423.274130193588;1436.8491308412674;745.1393640345301;746.1344839985591;768.2202564397141;773.5281478298234;775.2325198053886;6308.369163083747;6453.838654033687;6615.669216539154;6663.300353462817;6690.297518760557;571.7598608584321;580.135597959038;582.4670426559735;583.6731430398991;602.62637164958;4031.605549950568;4050.25070361984;4161.97919010403;4199.832006719758;4268.466441694788;13467.932660336635;13996.86003139976;14048.367823447968;14062.71874562503;14063.015588908678;11993.74065723104;12687.794659507332;13175.868241317465;13869.583912482642;13964.2319672419;7550.942867998485;8903.33225008127;9970.401775893324;10001.199904007808;10374.014468625468;5801.564882633735;6354.491640668828;6507.381798729113;6720.260771315249;6726.730930762715;11700.239484433485;12020.218685785396;12029.639110826689;12088.335141567299;12129.150959432754;12309.707480714396;12542.811857822322;12683.87316126827;12699.873001270238;12747.490100396251;8778.780530486534;8925.419847709878;9006.054364291655;9023.323250756088;9033.232175265177;9909.603615855285;10027;10213.642522511676;10257.58969641206;10278.434686092336;7391;8473.49159050459;8618.482891026559;8725.996510401385;8903.554822258991;8289.751307460785;8384.371172162235;8436.409451338348;8449.408541402043;8596.441231319945;7605;7620.3522700571075;7646.082470103401;7708.653110609924;7710.7686769397005;5469.179623056573;5917.940820591739;5931.436513531207;6001.309849367204;6044.304904935812;5903.881922361615;6019;6061.848453788691;6093.207882975362;6127 18:50:46 INFO - PID 2067 | |4;prototype.html;397.3999261115715;397.5547386926639;403.2720938705637;408.4016915219203;417.2322925816497;5140.845774626762;5508.669479831213;6245.751529449401;6256.09286653435;6301.684915754211;4964.4787297333805;4996.975015124928;6042.09368594711;6161.845953851156;6173;3767.6420740029653;4489.887752806173;4544.250198717207;4599.770011499429;4797.066405547453;4010.3182458981896;4820.758962051901;4844.442889067749;4848.296996935443;4857.34425852509;4638.8608341749805;4696.600788932945;4740.668153229275;4755;4775.546323099317;4734.455537613167;4766.356541866873;4777.829431789234;4778.020505796321;4811.663183577151;4206.326987681956;4227.894302642428;4230.048239146198;4235;4237.957620423787;5630.746616402272;5931.436513531207;5964.194833697482;6007.579469437142;6079.300880398767;4154.91690166195;4707.892790758083;4841.685290456109;5323.467653234684;5349.465053494659;6392.260527591365;6428.97387488016;6560.376764207393;6567.408933196035;6579.407853293179;4255.787210639455;4301;4301.741895486281;4315.611594956437;4326.956730432718;6228.221472316006;6603.80188594343;6886.003059112852;6969.0940177776565;6989.405900498464;4284.700070995063;4423.60187583119;4453.888652783641;4459;4466.464024317038;4029.992501874531;4212.368144778307;4327.480702315742;4544.046060194082;4545.204589196877;4532.342810292489;4708.670393072452;5053.216751403538;5057.786131328455;5082;5418.810341638024;6577.736890524421;6594.658896091914;6615.503837212132;6630.436412904861;1304.8499422566335;1545.590418539088;1549.884083459907;1551.8292987771335;1560.173108252628;951.7668171298076;1008.5360734062414;1018.4805749067881;1020.1481762728205;1029.763154474475;5951.589606209492;6265.937340626535;6285.717142728588;6294.65379404128;6345.873082538324;6719.790437721257;6736.360045795642;6824.2152152503095;6824.7952561423235;6832.419244364185;5563.221149039137;5822.737976791054;6221.564490485713;6249.9062514062325;6303.842403939938;3545.0679379738103;3581.1047238190454;3583.104223944014;3600.4419315005694;3602.6757591816863;6032.185654936615;6619.437347825393;6833.965830170917;6930.826729331807;6974.9651251744435;6046.065259117128;6093.542984276197;6475.838104047437;7013.92986070143;7073.540219885691;5865.325487568899;6399.712012959521;6412.583182093149;6697.430718388894;6953.582785032914;6097.74996125802;6187.071939209155;6779.830504237236;6793.592384456949;6818.318168183142;6047.485963693135;6420.967895160495;6706.362895524917;6743.831404214738;6744.22441419243;6646.833829154117;6784.118064651564;6833.4191593715095;6884.449244060564;7009.228984811769;4405.845795397146;4431.290993441163;4442.178197033559;4444.866654000385;4447.844325448594;5493.813588118961;6413.903791443226;6653.73385064592;6771.729130834711;6794.864102717819;6516.967415162894;6517;6553.5084868635995;6567.113439685581;6588.82568752301;5666.660000399825;5854.297484301911;6503.975651322158;6511.34886511364;6576.605403675795;6293;6319.704460585661;6345.206849143857;6356;6392.625585498954;6488.480921526361;6497.018409385183;6512.381323774234;6526.543141980016;6565.113709649328;5330.360356757214;5505.100740244609;6355.459785918249;6368.64972426521;6421.949573952522 18:50:46 INFO - PID 2067 | |5;yui.html;615.8029430582212;673.3098573961691;714.6605362452832;729.5877829026599;743.2381808646139;12307.507699692012;13701.3834377453;14844.703105937888;16029.118398488079;16060.598485037879;13382.397792099355;14331.211783351911;14712;14815.407383704638;15055.774163387558;902.8871391076116;925.065683659502;928.614624930653;929.3726734454216;929.8930622978343;911.7811725185974;944.2729098594112;948.1371951524114;948.5304774136812;951.3530799056639;970.6942313171364;977.9364341317792;979.0503211884461;980.0689345122126;983.8475036369374;979.6228452045942;989;990.5988074829705;992.6476100984155;994.1053052252958;736.2747693521877;736.7826491185114;737.2811508778951;737.9372753315974;742.9702811887518;16269.349226030945;16508.917455412768;16667.66664666712;16834.66330673392;17091.48725538236;14479.42082316706;14748.926255368655;14755.452907387651;14804.777928331083;14930.47743328989;11722.941385293105;11850.3482308473;11906.34515101669;11943.581974630846;12172.391380431032;2959.215807810932;2982.2246215984;3010.9247268818235;3087.7375423089065;3113.081640915935;103059.48470257675;107121;107210.46394767976;108150.59662188074;112379.43810280979;10948.781024379627;11045.171612129123;11429.885701142883;11720.06239500838;11904.047676185884;24500.387490312885;24700.25899223026;24937.251882443557;25066;25075.4984900301;7198.208197098315;7290.890636640454;7318.194998550155;7362.3373896349585;7499.175090740015;3478.930421391558;3955.3869150281753;4065.91868162641;4090.3046482098116;4090.6931980101613;3483.1292176955762;3922.235164143022;3989.5611482736876;4006.1186538961383;4006.4390985262085;792.7027364738224;792.8374683189933;801.5511313664366;805.7099444200084;815.4251252866715;520.4509242748936;528.2472476720734;553.3581045986637;562.1511517608359;585.2413497440165;9187.77030574241;9507.714768556816;9781.41311521311;10028.69913902584;10055.748606284755;484.4646665434714;544.2353493341782;559.2048186798221;581.201514706686;592.2862950145064;4041.656459201001;4600.723956562617;4646.581807637329;4750.857474275777;5157.303763991813;75620;94401.5279923596;96953;98244.50877745709;101308.97382052465;81630.59184704038;82505;82684;84051;85508;50266;75339.24660753542;76484;76569.23430765733;79787.60106199431;9298.628054877729;10712.250142490262;10746.46267686597;10803.081738052038;10874;27491.587626186025;36336.636633634385;36805.079873003386;36828.52685892535;37215.813920930224;46109.769451152526;46423.071538568365;46797;46933;47467.52532474631;12718.300493472947;13308.733825323246;13436.664083397993;13943.930280348533;14094.78857817113;14057.789133162807;14111.435542578181;14519.854801451851;14836.851631483978;15123.39506419731;13625.114367566077;13798.310084495533;13953.093048951785;14262.57212283633;14320.355583998953;13144.80282795778;13285.269310188032;13292.069555131047;13771.242581658105;13979.370928308048;13095.738085238432;13196.868031319947;13242.933785331012;13381.045758140139;13547.322633868464;9545.991830546043;9616.95191524038;9662.275329350467;9859.35914165577;9900.75248118774;9095.95452022762;10093.343932644355;10936.56253749841;11231.55073797039;11455.541778329107 18:50:46 INFO - PID 2067 | __end_tp_report 18:50:46 INFO - PID 2067 | __start_cc_report 18:50:46 INFO - PID 2067 | _x_x_mozilla_cycle_collect,426 18:50:46 INFO - PID 2067 | __end_cc_report 18:50:46 INFO - PID 2067 | __startTimestamp1490406646336__endTimestamp 18:50:46 INFO - PID 2067 | 18:50:46 INFO - PID 2067 | ------- Summary: start ------- 18:50:46 INFO - PID 2067 | Number of tests: 6 18:50:46 INFO - PID 2067 | 18:50:46 INFO - PID 2067 | [#0] dojo.html Cycles:165 Average:6145.13 Median:6314.43 stddev:695.02 (11.0%) stddev-sans-first:666.39 18:50:46 INFO - PID 2067 | Values: 3538.6 3552.9 3559.1 3602.7 3611.8 5839.2 5887.4 5940.7 5994.6 6099.8 6102.9 6157.7 6175.2 6193.7 6246.8 5101.7 5685.1 5764.2 5789.3 5900.4 5653.0 5742.2 5847.9 5855.1 5905.8 5591.2 5808.3 5842.9 5880.0 5901.7 4481.3 5712.5 5784.2 5791.3 5820.4 5674.3 5679.4 5694.6 5740.8 5776.9 4928.7 6114.8 6117.9 6120.8 6201.8 6598.2 6626.0 6648.8 6673.9 6679.4 6770.2 6776.9 6789.5 6793.4 6797.6 6147.8 6254.7 6262.9 6267.8 6271.9 6644.4 6796.3 6864.1 6902.4 6906.5 6309.3 6396.8 6459.4 6545.6 6552.4 6530.1 6538.3 6588.8 6718.4 6786.4 6632.6 6646.3 6656.8 6670.3 6670.8 6364.1 6474.1 6479.0 6535.5 6674.4 5305.3 5352.9 5361.9 5376.1 5378.1 4186.7 4701.5 4730.0 4735.9 4744.4 6190.6 6247.8 6314.4 6320.1 6341.6 5718.7 6674.0 6681.8 6736.8 6741.9 6289.6 6290.7 6319.3 6348.5 6352.9 5796.9 5973.0 5975.8 6003.2 6009.6 6659.0 6786.1 6821.5 6859.9 6881.3 6792.1 6792.7 6808.4 6812.7 6832.7 6473.0 6825.0 6851.3 6881.6 6888.8 5536.9 6444.4 6546.0 6607.0 6677.7 5834.4 6718.2 6731.7 6738.6 6744.8 6185.3 6322.6 6465.3 6467.2 6474.9 6303.1 6380.9 6436.9 6451.0 6487.4 6250.5 6259.3 6340.7 6350.3 6366.6 6403.1 6458.1 6487.2 6493.2 6494.2 5706.3 5848.8 6198.9 6219.8 6235.3 18:50:46 INFO - PID 2067 | 18:50:46 INFO - PID 2067 | [#1] ext.html Cycles:180 Average:51017.54 Median:35318.23 stddev:101350.85 (287.0%) stddev-sans-first:101564.84 18:50:46 INFO - PID 2067 | Values: 731.7 804.5 825.4 1173.4 1281.8 37039.6 37677.2 37783.6 37831.0 37915.4 36715.0 37139.4 37191.0 37239.0 37244.0 7951.2 8141.2 8298.4 8515.1 8536.1 8481.1 8596.0 8599.0 8605.6 8610.0 8558.0 8594.6 8616.2 8621.3 8630.8 7677.2 8066.5 8582.0 8602.2 8644.3 8374.5 8479.9 8556.0 8561.9 8579.3 37697.9 37977.0 38025.6 38049.4 38171.0 2631.5 2989.7 3019.6 3026.9 3034.9 27286.0 27570.2 27657.7 27716.2 28363.7 2780.6 2783.2 2792.5 2798.6 2829.9 232556.0 245377.8 248406.8 299479.0 303520.5 45419.3 45443.8 45534.3 45679.8 45769.3 47090.5 47106.5 47122.6 47230.8 47282.5 14174.2 14216.6 14290.9 14327.4 14372.7 11908.8 11938.5 11942.1 11956.7 11967.4 13569.7 13601.7 13633.4 13651.7 13729.2 5939.8 5973.9 5996.3 5998.2 6004.0 948.7 969.2 974.9 980.7 1023.4 23536.1 28739.4 28806.6 29631.6 30389.9 994.4 1048.7 1077.7 1084.2 1099.2 11892.9 12287.8 12842.9 14603.7 15278.6 358671.0 388320.0 421327.0 456532.7 459350.0 56789.4 56856.9 57008.0 57136.1 57446.7 1417.4 1468.6 1472.1 1472.3 1483.1 27533.7 28171.7 28554.9 28858.4 28859.7 31754.0 34438.5 36952.1 38094.6 38366.0 435460.0 435686.0 436151.0 437922.8 438321.0 31631.7 33570.0 34521.3 34586.7 34788.1 34759.8 41337.4 41461.0 41556.8 44278.9 23996.8 28460.6 30513.5 30533.5 30540.0 29562.9 30186.4 30344.9 30450.7 30497.4 34959.8 35676.6 36338.6 36458.5 36556.8 26052.6 27391.7 30697.4 30956.0 30984.1 22772.9 23832.9 24109.4 24308.9 24911.1 18:50:46 INFO - PID 2067 | 18:50:46 INFO - PID 2067 | [#2] jquery.html Cycles:180 Average:38306.98 Median:13007.06 stddev:106252.23 (816.9%) stddev-sans-first:106512.22 18:50:46 INFO - PID 2067 | Values: 423.0 430.4 437.2 445.9 462.8 19009.4 20834.5 21380.5 21534.4 21608.1 21701.5 22613.1 23343.3 23365.4 23659.8 6060.8 6184.7 6248.9 6266.1 6279.6 5969.5 6170.7 6181.7 6237.7 6246.8 5973.5 6093.1 6164.1 6191.6 6227.7 6112.7 6157.0 6172.5 6173.8 6176.3 5400.0 5421.8 5495.8 5498.4 5504.5 27073.8 27255.5 27387.5 27416.9 27842.0 1644.6 1994.7 2011.6 2060.5 2114.9 16075.1 16725.7 16748.6 16748.7 17409.4 1583.9 1663.3 1685.7 1715.4 1741.4 143012.0 153303.0 158550.0 162281.4 163341.4 12764.9 12933.7 12963.0 13116.6 13155.0 16441.0 16634.9 16642.1 16659.8 16671.0 6676.0 8741.8 8994.9 9198.7 9212.5 7134.0 8621.7 8709.3 8781.2 8893.6 6569.7 7815.1 7907.2 7965.4 7966.4 2004.2 2131.0 2162.4 2165.2 2354.4 884.6 908.8 922.3 950.6 975.7 20493.7 21071.7 21111.9 21132.7 21158.4 904.9 963.4 977.0 990.4 997.4 10774.9 11028.0 11059.9 11069.5 11075.3 603834.0 624559.0 626351.0 640351.0 655512.0 101542.9 108177.0 146986.0 160158.0 160252.0 972.9 1179.5 1226.8 1241.4 1246.1 21183.6 21316.9 21351.8 21417.6 21462.6 56541.2 57166.1 57849.0 61591.4 62002.7 89478.6 89816.0 89834.6 90269.0 90425.4 7122.9 7734.7 7988.9 8353.7 8479.7 11559.8 12379.3 12910.7 13508.7 13527.7 9586.7 10845.2 11176.0 11183.6 11370.7 9622.7 10161.8 10179.3 10441.7 10546.4 10718.5 11063.1 11697.4 11990.9 11991.4 8466.4 8555.6 8638.2 8726.6 8749.8 11410.8 11488.0 11656.8 11670.1 11773.6 18:50:46 INFO - PID 2067 | 18:50:46 INFO - PID 2067 | [#3] mootools.html Cycles:180 Average:6808.84 Median:3265.58 stddev:4167.43 (127.6%) stddev-sans-first:4158.87 18:50:46 INFO - PID 2067 | Values: 1341.5 1373.5 1382.5 1393.5 1418.5 10565.5 10897.3 11043.6 11054.8 11207.3 10795.7 11031.7 11199.8 11216.3 11241.0 2438.5 2487.7 2490.4 2499.2 2499.6 2355.7 2406.6 2454.7 2460.2 2462.2 2419.7 2422.7 2441.1 2454.5 2466.8 2364.8 2426.3 2437.8 2440.8 2458.1 2347.5 2430.9 2440.0 2458.0 2460.7 11139.3 11211.0 11212.2 11229.6 11241.0 6264.2 6495.4 6501.4 6519.9 6522.4 4043.6 4080.3 4081.9 4113.2 4179.0 1115.7 1133.8 1197.3 1242.2 1247.1 13872.9 14330.6 15415.2 15552.4 15565.7 5641.2 5687.4 5919.2 5950.9 5976.7 12583.2 12599.8 12627.0 12668.4 12695.0 6351.0 6404.2 6415.3 6417.6 6419.4 5642.2 5755.8 5836.2 5849.7 5911.6 4451.9 4484.2 4503.9 4537.5 4541.8 1386.5 1414.5 1418.7 1423.3 1436.8 745.1 746.1 768.2 773.5 775.2 6308.4 6453.8 6615.7 6663.3 6690.3 571.8 580.1 582.5 583.7 602.6 4031.6 4050.3 4162.0 4199.8 4268.5 13467.9 13996.9 14048.4 14062.7 14063.0 11993.7 12687.8 13175.9 13869.6 13964.2 7550.9 8903.3 9970.4 10001.2 10374.0 5801.6 6354.5 6507.4 6720.3 6726.7 11700.2 12020.2 12029.6 12088.3 12129.2 12309.7 12542.8 12683.9 12699.9 12747.5 8778.8 8925.4 9006.1 9023.3 9033.2 9909.6 10027.0 10213.6 10257.6 10278.4 7391.0 8473.5 8618.5 8726.0 8903.6 8289.8 8384.4 8436.4 8449.4 8596.4 7605.0 7620.4 7646.1 7708.7 7710.8 5469.2 5917.9 5931.4 6001.3 6044.3 5903.9 6019.0 6061.8 6093.2 6127.0 18:50:46 INFO - PID 2067 | 18:50:46 INFO - PID 2067 | [#4] prototype.html Cycles:180 Average:5287.62 Median:5985.89 stddev:1631.61 (27.3%) stddev-sans-first:1594.37 18:50:46 INFO - PID 2067 | Values: 397.4 397.6 403.3 408.4 417.2 5140.8 5508.7 6245.8 6256.1 6301.7 4964.5 4997.0 6042.1 6161.8 6173.0 3767.6 4489.9 4544.3 4599.8 4797.1 4010.3 4820.8 4844.4 4848.3 4857.3 4638.9 4696.6 4740.7 4755.0 4775.5 4734.5 4766.4 4777.8 4778.0 4811.7 4206.3 4227.9 4230.0 4235.0 4238.0 5630.7 5931.4 5964.2 6007.6 6079.3 4154.9 4707.9 4841.7 5323.5 5349.5 6392.3 6429.0 6560.4 6567.4 6579.4 4255.8 4301.0 4301.7 4315.6 4327.0 6228.2 6603.8 6886.0 6969.1 6989.4 4284.7 4423.6 4453.9 4459.0 4466.5 4030.0 4212.4 4327.5 4544.0 4545.2 4532.3 4708.7 5053.2 5057.8 5082.0 5418.8 6577.7 6594.7 6615.5 6630.4 1304.8 1545.6 1549.9 1551.8 1560.2 951.8 1008.5 1018.5 1020.1 1029.8 5951.6 6265.9 6285.7 6294.7 6345.9 6719.8 6736.4 6824.2 6824.8 6832.4 5563.2 5822.7 6221.6 6249.9 6303.8 3545.1 3581.1 3583.1 3600.4 3602.7 6032.2 6619.4 6834.0 6930.8 6975.0 6046.1 6093.5 6475.8 7013.9 7073.5 5865.3 6399.7 6412.6 6697.4 6953.6 6097.7 6187.1 6779.8 6793.6 6818.3 6047.5 6421.0 6706.4 6743.8 6744.2 6646.8 6784.1 6833.4 6884.4 7009.2 4405.8 4431.3 4442.2 4444.9 4447.8 5493.8 6413.9 6653.7 6771.7 6794.9 6517.0 6517.0 6553.5 6567.1 6588.8 5666.7 5854.3 6504.0 6511.3 6576.6 6293.0 6319.7 6345.2 6356.0 6392.6 6488.5 6497.0 6512.4 6526.5 6565.1 5330.4 5505.1 6355.5 6368.6 6421.9 18:50:46 INFO - PID 2067 | 18:50:46 INFO - PID 2067 | [#5] yui.html Cycles:180 Average:19040.72 Median:3997.84 stddev:27065.37 (677.0%) stddev-sans-first:27105.94 18:50:46 INFO - PID 2067 | Values: 615.8 673.3 714.7 729.6 743.2 12307.5 13701.4 14844.7 16029.1 16060.6 13382.4 14331.2 14712.0 14815.4 15055.8 902.9 925.1 928.6 929.4 929.9 911.8 944.3 948.1 948.5 951.4 970.7 977.9 979.1 980.1 983.8 979.6 989.0 990.6 992.6 994.1 736.3 736.8 737.3 737.9 743.0 16269.3 16508.9 16667.7 16834.7 17091.5 14479.4 14748.9 14755.5 14804.8 14930.5 11722.9 11850.3 11906.3 11943.6 12172.4 2959.2 2982.2 3010.9 3087.7 3113.1 103059.5 107121.0 107210.5 108150.6 112379.4 10948.8 11045.2 11429.9 11720.1 11904.0 24500.4 24700.3 24937.3 25066.0 25075.5 7198.2 7290.9 7318.2 7362.3 7499.2 3478.9 3955.4 4065.9 4090.3 4090.7 3483.1 3922.2 3989.6 4006.1 4006.4 792.7 792.8 801.6 805.7 815.4 520.5 528.2 553.4 562.2 585.2 9187.8 9507.7 9781.4 10028.7 10055.7 484.5 544.2 559.2 581.2 592.3 4041.7 4600.7 4646.6 4750.9 5157.3 75620.0 94401.5 96953.0 98244.5 101309.0 81630.6 82505.0 82684.0 84051.0 85508.0 50266.0 75339.2 76484.0 76569.2 79787.6 9298.6 10712.3 10746.5 10803.1 10874.0 27491.6 36336.6 36805.1 36828.5 37215.8 46109.8 46423.1 46797.0 46933.0 47467.5 12718.3 13308.7 13436.7 13943.9 14094.8 14057.8 14111.4 14519.9 14836.9 15123.4 13625.1 13798.3 13953.1 14262.6 14320.4 13144.8 13285.3 13292.1 13771.2 13979.4 13095.7 13196.9 13242.9 13381.0 13547.3 9546.0 9617.0 9662.3 9859.4 9900.8 9096.0 10093.3 10936.6 11231.6 11455.5 18:50:46 INFO - PID 2067 | -------- Summary: end -------- 18:50:46 INFO - PID 2067 | 18:50:46 INFO - TEST-INFO | 2067: exit 0 18:50:46 INFO - TEST-OK | dromaeo_css | took 1117629ms 18:50:47 INFO - TEST-START | kraken 18:50:47 INFO - operating with platform_type : mac_ 18:50:47 INFO - Initialising browser for kraken test... 18:50:47 INFO - TEST-INFO | started process 2187 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/tmpFzYpOw/profile http://localhost:52063/getInfo.html) 18:50:50 INFO - PID 2187 | 2017-03-24 18:50:50.050 plugin-container[2188:17229] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x893f, name = 'com.apple.tsm.portname' 18:50:50 INFO - PID 2187 | See /usr/include/servers/bootstrap_defs.h for the error codes. 18:50:50 INFO - PID 2187 | 2017-03-24 18:50:50.053 plugin-container[2188:17229] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4617, name = 'com.apple.CFPasteboardClient' 18:50:50 INFO - PID 2187 | See /usr/include/servers/bootstrap_defs.h for the error codes. 18:50:50 INFO - PID 2187 | 2017-03-24 18:50:50.053 plugin-container[2188:17229] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 18:50:50 INFO - PID 2187 | __metrics Screen width/height:1600/1200 18:50:50 INFO - PID 2187 | colorDepth:24 18:50:50 INFO - PID 2187 | Browser inner width/height: 1024/689 18:50:50 INFO - PID 2187 | __metrics 18:50:50 ERROR - PID 2187 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3392: TypeError: this.tabs is undefined 18:50:50 INFO - TEST-INFO | 2187: exit 0 18:50:50 INFO - Browser initialized. 18:50:50 INFO - Running cycle 1/1 for kraken test... 18:50:50 INFO - TEST-INFO | started process 2189 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/tmpFzYpOw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:50:53 INFO - PID 2189 | 2017-03-24 18:50:53.498 plugin-container[2191:17343] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x873f, name = 'com.apple.tsm.portname' 18:50:53 INFO - PID 2189 | See /usr/include/servers/bootstrap_defs.h for the error codes. 18:50:53 INFO - PID 2189 | 2017-03-24 18:50:53.498 plugin-container[2191:17343] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4517, name = 'com.apple.CFPasteboardClient' 18:50:53 INFO - PID 2189 | See /usr/include/servers/bootstrap_defs.h for the error codes. 18:50:53 INFO - PID 2189 | 2017-03-24 18:50:53.498 plugin-container[2191:17343] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 18:51:03 INFO - PID 2189 | RSS: Main: 227926016 18:51:03 INFO - PID 2189 | 18:51:06 INFO - PID 2189 | Cycle 1(1): loaded http://localhost:52063/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52063/tests/kraken/driver.html?testName=audio-beat-detection) 18:51:06 INFO - PID 2189 | RSS: Main: 242294784 18:51:06 INFO - PID 2189 | 18:51:09 INFO - PID 2189 | Cycle 1(1): loaded http://localhost:52063/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52063/tests/kraken/driver.html?testName=audio-dft) 18:51:10 INFO - PID 2189 | RSS: Main: 250564608 18:51:10 INFO - PID 2189 | 18:51:13 INFO - PID 2189 | Cycle 1(1): loaded http://localhost:52063/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52063/tests/kraken/driver.html?testName=audio-fft) 18:51:14 INFO - PID 2189 | RSS: Main: 253145088 18:51:14 INFO - PID 2189 | 18:51:16 INFO - PID 2189 | Cycle 1(1): loaded http://localhost:52063/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52063/tests/kraken/driver.html?testName=audio-oscillator) 18:51:16 INFO - PID 2189 | RSS: Main: 255594496 18:51:16 INFO - PID 2189 | 18:51:18 INFO - PID 2189 | Cycle 1(1): loaded http://localhost:52063/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52063/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:51:19 INFO - PID 2189 | RSS: Main: 256139264 18:51:19 INFO - PID 2189 | 18:51:22 INFO - PID 2189 | Cycle 1(1): loaded http://localhost:52063/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52063/tests/kraken/driver.html?testName=imaging-darkroom) 18:51:23 INFO - PID 2189 | RSS: Main: 261771264 18:51:23 INFO - PID 2189 | 18:51:26 INFO - PID 2189 | Cycle 1(1): loaded http://localhost:52063/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52063/tests/kraken/driver.html?testName=imaging-desaturate) 18:51:26 INFO - PID 2189 | RSS: Main: 261926912 18:51:26 INFO - PID 2189 | 18:51:29 INFO - PID 2189 | Cycle 1(1): loaded http://localhost:52063/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52063/tests/kraken/driver.html?testName=json-parse-financial) 18:51:30 INFO - PID 2189 | RSS: Main: 261959680 18:51:30 INFO - PID 2189 | 18:51:32 INFO - PID 2189 | Cycle 1(1): loaded http://localhost:52063/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52063/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:51:32 INFO - PID 2189 | RSS: Main: 261431296 18:51:32 INFO - PID 2189 | 18:51:34 INFO - PID 2189 | Cycle 1(1): loaded http://localhost:52063/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52063/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:51:35 INFO - PID 2189 | RSS: Main: 261586944 18:51:35 INFO - PID 2189 | 18:51:37 INFO - PID 2189 | Cycle 1(1): loaded http://localhost:52063/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52063/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:51:38 INFO - PID 2189 | RSS: Main: 261517312 18:51:38 INFO - PID 2189 | 18:51:41 INFO - PID 2189 | Cycle 1(1): loaded http://localhost:52063/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52063/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:51:42 INFO - PID 2189 | RSS: Main: 261881856 18:51:42 INFO - PID 2189 | 18:51:45 INFO - PID 2189 | Cycle 1(1): loaded http://localhost:52063/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52063/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:51:45 INFO - PID 2189 | RSS: Main: 261971968 18:51:45 INFO - PID 2189 | 18:51:47 INFO - PID 2189 | Cycle 1(1): loaded http://localhost:52063/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52063/tests/kraken/driver.html?testName=ai-astar) 18:51:47 INFO - PID 2189 | RSS: Main: 263766016 18:51:47 INFO - PID 2189 | 18:51:47 INFO - PID 2189 | __start_tp_report 18:51:47 INFO - PID 2189 | _x_x_mozilla_page_load 18:51:47 INFO - PID 2189 | _x_x_mozilla_page_load_details 18:51:47 INFO - PID 2189 | |i|pagename|runs| 18:51:47 INFO - PID 2189 | |0;ai-astar;150;124;115;116;119;116;116;116;115;116 18:51:47 INFO - PID 2189 | |1;audio-beat-detection;152;136;146;155;113;116;116;115;138;116 18:51:47 INFO - PID 2189 | |2;audio-dft;197;212;211;211;222;203;200;201;196;198 18:51:47 INFO - PID 2189 | |3;audio-fft;83;56;62;89;58;64;60;63;76;59 18:51:47 INFO - PID 2189 | |4;audio-oscillator;85;70;86;71;72;71;96;102;72;83 18:51:47 INFO - PID 2189 | |5;imaging-gaussian-blur;122;130;88;95;89;103;102;135;89;91 18:51:47 INFO - PID 2189 | |6;imaging-darkroom;96;98;103;96;95;121;96;96;96;97 18:51:47 INFO - PID 2189 | |7;imaging-desaturate;89;93;99;90;132;147;121;91;92;89 18:51:47 INFO - PID 2189 | |8;json-parse-financial;67;68;68;67;70;67;67;67;67;67 18:51:47 INFO - PID 2189 | |9;json-stringify-tinderbox;56;61;66;67;65;57;56;58;64;86 18:51:47 INFO - PID 2189 | |10;stanford-crypto-aes;86;89;101;103;107;106;89;93;107;108 18:51:47 INFO - PID 2189 | |11;stanford-crypto-ccm;149;141;144;142;140;163;160;159;171;159 18:51:47 INFO - PID 2189 | |12;stanford-crypto-pbkdf2;230;233;187;212;233;203;190;185;198;185 18:51:47 INFO - PID 2189 | |13;stanford-crypto-sha256-iterative;72;70;68;70;68;69;69;87;89;98 18:51:47 INFO - PID 2189 | __end_tp_report 18:51:47 INFO - PID 2189 | __start_cc_report 18:51:47 INFO - PID 2189 | _x_x_mozilla_cycle_collect,991 18:51:47 INFO - PID 2189 | __end_cc_report 18:51:47 INFO - PID 2189 | __startTimestamp1490406707970__endTimestamp 18:51:47 INFO - PID 2189 | 18:51:47 INFO - PID 2189 | ------- Summary: start ------- 18:51:47 INFO - PID 2189 | Number of tests: 14 18:51:47 INFO - PID 2189 | 18:51:47 INFO - PID 2189 | [#0] ai-astar Cycles:10 Average:120.30 Median:116.00 stddev:10.78 (9.3%) stddev-sans-first:2.87 18:51:47 INFO - PID 2189 | Values: 150.0 124.0 115.0 116.0 119.0 116.0 116.0 116.0 115.0 116.0 18:51:47 INFO - PID 2189 | 18:51:47 INFO - PID 2189 | [#1] audio-beat-detection Cycles:10 Average:130.30 Median:137.00 stddev:16.89 (12.3%) stddev-sans-first:15.98 18:51:47 INFO - PID 2189 | Values: 152.0 136.0 146.0 155.0 113.0 116.0 116.0 115.0 138.0 116.0 18:51:47 INFO - PID 2189 | 18:51:47 INFO - PID 2189 | [#2] audio-dft Cycles:10 Average:205.10 Median:207.00 stddev:8.49 (4.1%) stddev-sans-first:8.49 18:51:47 INFO - PID 2189 | Values: 197.0 212.0 211.0 211.0 222.0 203.0 200.0 201.0 196.0 198.0 18:51:47 INFO - PID 2189 | 18:51:47 INFO - PID 2189 | [#3] audio-fft Cycles:10 Average:67.00 Median:63.50 stddev:11.48 (18.1%) stddev-sans-first:10.62 18:51:47 INFO - PID 2189 | Values: 83.0 56.0 62.0 89.0 58.0 64.0 60.0 63.0 76.0 59.0 18:51:47 INFO - PID 2189 | 18:51:47 INFO - PID 2189 | [#4] audio-oscillator Cycles:10 Average:80.80 Median:77.50 stddev:11.52 (14.9%) stddev-sans-first:12.11 18:51:47 INFO - PID 2189 | Values: 85.0 70.0 86.0 71.0 72.0 71.0 96.0 102.0 72.0 83.0 18:51:47 INFO - PID 2189 | 18:51:47 INFO - PID 2189 | [#5] imaging-gaussian-blur Cycles:10 Average:104.40 Median:88.50 stddev:18.01 (20.4%) stddev-sans-first:17.95 18:51:47 INFO - PID 2189 | Values: 122.0 130.0 88.0 95.0 89.0 103.0 102.0 135.0 89.0 91.0 18:51:47 INFO - PID 2189 | 18:51:47 INFO - PID 2189 | [#6] imaging-darkroom Cycles:10 Average:99.40 Median:96.00 stddev:7.92 (8.2%) stddev-sans-first:8.30 18:51:47 INFO - PID 2189 | Values: 96.0 98.0 103.0 96.0 95.0 121.0 96.0 96.0 96.0 97.0 18:51:47 INFO - PID 2189 | 18:51:47 INFO - PID 2189 | [#7] imaging-desaturate Cycles:10 Average:104.30 Median:90.50 stddev:21.15 (23.4%) stddev-sans-first:21.70 18:51:47 INFO - PID 2189 | Values: 89.0 93.0 99.0 90.0 132.0 147.0 121.0 91.0 92.0 89.0 18:51:47 INFO - PID 2189 | 18:51:47 INFO - PID 2189 | [#8] json-parse-financial Cycles:10 Average:67.50 Median:67.00 stddev:0.97 (1.5%) stddev-sans-first:1.01 18:51:47 INFO - PID 2189 | Values: 67.0 68.0 68.0 67.0 70.0 67.0 67.0 67.0 67.0 67.0 18:51:47 INFO - PID 2189 | 18:51:47 INFO - PID 2189 | [#9] json-stringify-tinderbox Cycles:10 Average:63.60 Median:64.50 stddev:8.93 (13.9%) stddev-sans-first:9.04 18:51:47 INFO - PID 2189 | Values: 56.0 61.0 66.0 67.0 65.0 57.0 56.0 58.0 64.0 86.0 18:51:47 INFO - PID 2189 | 18:51:47 INFO - PID 2189 | [#10] stanford-crypto-aes Cycles:10 Average:98.90 Median:97.00 stddev:8.71 (9.0%) stddev-sans-first:7.89 18:51:47 INFO - PID 2189 | Values: 86.0 89.0 101.0 103.0 107.0 106.0 89.0 93.0 107.0 108.0 18:51:47 INFO - PID 2189 | 18:51:47 INFO - PID 2189 | [#11] stanford-crypto-ccm Cycles:10 Average:152.80 Median:159.00 stddev:10.93 (6.9%) stddev-sans-first:11.51 18:51:47 INFO - PID 2189 | Values: 149.0 141.0 144.0 142.0 140.0 163.0 160.0 159.0 171.0 159.0 18:51:47 INFO - PID 2189 | 18:51:47 INFO - PID 2189 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:205.60 Median:207.50 stddev:20.11 (9.7%) stddev-sans-first:19.30 18:51:47 INFO - PID 2189 | Values: 230.0 233.0 187.0 212.0 233.0 203.0 190.0 185.0 198.0 185.0 18:51:47 INFO - PID 2189 | 18:51:47 INFO - PID 2189 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.00 Median:71.00 stddev:10.99 (15.5%) stddev-sans-first:11.57 18:51:47 INFO - PID 2189 | Values: 72.0 70.0 68.0 70.0 68.0 69.0 69.0 87.0 89.0 98.0 18:51:47 INFO - PID 2189 | -------- Summary: end -------- 18:51:47 INFO - PID 2189 | 18:51:48 INFO - TEST-INFO | 2189: exit 0 18:51:48 INFO - TEST-OK | kraken | took 61880ms 18:51:48 INFO - SUITE-END | took 1179s 18:51:49 INFO - Completed test suite (00:19:39) 18:51:49 INFO - javascript benchmark 18:51:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7654.827426061392, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3538.5930617978925, 3552.8756493522733, 3559.0568499347673, 3602.675759181673, 3611.78329300242, 5839.240898683176, 5887.4406931341455, 5940.663350746086, 5994.58037937344, 6099.7865074722395, 6102.938970610293, 6157.722902469389, 6175.197224360838, 6193.721282542285, 6246.812595622138, 5101.6683915545555, 5685.147227915804, 5764.193012978187, 5789.2763404574425, 5900.409959004108, 5652.971735141318, 5742.196092547047, 5847.853803654922, 5855.121731740231, 5905.763769449239, 5591.245181900432, 5808.332041815203, 5842.941570584325, 5880.0, 5901.734421951001, 4481.305397663367, 5712.514436272922, 5784.1902133701315, 5791.333996590404, 5820.3888591698105, 5674.3190817101795, 5679.375268720438, 5694.629849059798, 5740.799072032459, 5776.8844623107725, 4928.654994150411, 6114.814446323758, 6117.938820611826, 6120.846978825521, 6201.782937597162, 6598.175228096488, 6625.966870165618, 6648.800535983928, 6673.899891501631, 6679.398854103106, 6770.221424536192, 6776.864462710768, 6789.490788190906, 6793.388595026422, 6797.5581587196675, 6147.754089836446, 6254.6872656366995, 6262.87474250517, 6267.843303917347, 6271.937280627227, 6644.435223006002, 6796.286389929085, 6864.141982252218, 6902.447804175654, 6906.516543841984, 6309.33751956038, 6396.776112836028, 6459.354064593503, 6545.574537655038, 6552.4102830744505, 6530.053142294436, 6538.346165383518, 6588.769393071316, 6718.361755633305, 6786.3892249697765, 6632.568883022588, 6646.302138275508, 6656.767013154613, 6670.332966703388, 6670.833229169212, 6364.109024736541, 6474.093626892239, 6479.028145778171, 6535.5425120241125, 6674.399304062657, 5305.257263983045, 5352.892942141136, 5361.946380536223, 5376.139817629239, 5378.058839703114, 4186.727862688916, 4701.48283688794, 4729.976350118227, 4735.905281894343, 4744.430668319824, 6190.597611155261, 6247.75008999644, 6314.431701146918, 6320.146780184617, 6341.587796793194, 5718.656880587178, 6673.998900165014, 6681.832954176088, 6736.797896063126, 6741.932580674229, 6289.591176573508, 6290.654014029273, 6319.273283572356, 6348.492120630339, 6352.936470635327, 5796.942030579725, 5973.044312909914, 5975.820725378246, 6003.159557661931, 6009.609375390585, 6658.96670516654, 6786.083878676315, 6821.454283657196, 6859.931400686129, 6881.346272104142, 6792.117024786746, 6792.694328755317, 6808.421284190701, 6812.693428795816, 6832.726690932307, 6472.967635161794, 6824.965875170791, 6851.3491218334175, 6881.587104773729, 6888.793336199922, 5536.889262214814, 6444.420002199825, 6545.967270163619, 6606.966965165144, 6677.699503522256, 5834.445727655866, 6718.193816742022, 6731.730730770714, 6738.561993470409, 6744.831379215559, 6185.2886918003205, 6322.589031712924, 6465.2564955030775, 6467.159269294962, 6474.935250647433, 6303.149074874833, 6380.93619063822, 6436.9034464484, 6451.0, 6487.416132548094, 6250.468710159687, 6259.311475737574, 6340.651264180515, 6350.333215012542, 6366.586171898997, 6403.135576697086, 6458.095866578588, 6487.18910136233, 6493.188351456068, 6494.155759751202, 5706.258186435737, 5848.766049357978, 6198.938010619836, 6219.813405597839, 6235.3452887446165], "value": 6101.706464380545, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [731.73657483306, 804.5092493578916, 825.3809642767926, 1173.425021739348, 1281.7756892543803, 37039.62960370396, 37677.24645507088, 37783.62216377835, 37830.999999999935, 37915.431268530956, 36715.0, 37139.442908356395, 37191.0, 37239.0, 37244.0, 7951.244631760002, 8141.1858814118705, 8298.419110662226, 8515.105913879046, 8536.103709110546, 8481.109483504235, 8596.0, 8598.957005214965, 8605.612747426381, 8610.0, 8558.0, 8594.613242404106, 8616.224539791418, 8621.267192288664, 8630.827383452359, 7677.232276772306, 8066.516009039477, 8581.957090214572, 8602.18279263469, 8644.308455323622, 8374.539400332978, 8479.915200847974, 8556.01605815333, 8561.914380856237, 8579.270761985239, 37697.86906392813, 37977.0, 38025.61974380248, 38049.42925856114, 38171.0, 2631.5000149971634, 2989.671136175019, 3019.607451031352, 3026.8940587079346, 3034.908952731422, 27286.04498842531, 27570.17289481319, 27657.723422765917, 27716.168514944584, 28363.716362836312, 2780.6107144999714, 2783.151138902634, 2792.46943080814, 2798.5802129680505, 2829.9434011319863, 232556.0, 245377.7731111333, 248406.757966209, 299479.0, 303520.4823975888, 45419.31871021937, 45443.772781135885, 45534.31698524525, 45679.77160114178, 45769.31346029812, 47090.5290947093, 47106.528934710215, 47122.58632241038, 47230.76384618055, 47282.52717472781, 14174.220417877115, 14216.573502794932, 14290.857091429161, 14327.426902923766, 14372.712545749026, 11908.821367679491, 11938.462769175409, 11942.104342174373, 11956.744541823156, 11967.40162991847, 13569.728605427836, 13601.727965440636, 13633.386497607631, 13651.658708532168, 13729.244891530861, 5939.821805345847, 5973.940260597338, 5996.310424301174, 5998.220231369981, 6003.969980150158, 948.6964171465203, 969.2391472693902, 974.8837580969891, 980.7499087732582, 1023.4319952426326, 23536.114831770356, 28739.425211495654, 28806.567901481496, 29631.555526667118, 30389.936352227567, 994.393420013791, 1048.6696690542456, 1077.6798421933227, 1084.1976937066513, 1099.1866019145775, 11892.940535297268, 12287.75424491523, 12842.871571284355, 14603.707925841423, 15278.643716113995, 358671.0, 388320.0, 421327.0, 456532.7173364178, 459350.0, 56789.43210567924, 56856.86286274334, 57008.0, 57136.14295785566, 57446.712766436736, 1417.376354404059, 1468.566772802026, 1472.0799500312091, 1472.3153733513752, 1483.1027228526586, 27533.724662753917, 28171.71828281773, 28554.85722571374, 28858.42283154283, 28859.711402886544, 31754.0, 34438.48342274918, 36952.07619809526, 38094.61905380911, 38366.0, 435460.0, 435686.0, 436151.0, 437922.810385946, 438321.0, 31631.683683163796, 33569.99290021303, 34521.30957380889, 34586.65413345935, 34788.130296742784, 34759.82620086883, 41337.379939301536, 41461.0, 41556.792216038724, 44278.89302767457, 23996.782154864235, 28460.573091403232, 30513.54229686601, 30533.54199687051, 30540.0, 29562.852185738935, 30186.396272073995, 30344.937927172443, 30450.695493044786, 30497.39005219839, 34959.825200873835, 35676.64323356733, 36338.63661363458, 36458.453123203704, 36556.81721591375, 26052.609210861472, 27391.726082739715, 30697.386052278383, 30956.0, 30984.0704778857, 22772.886135569217, 23832.880835596403, 24109.397265068514, 24308.87845560761, 24911.128110516045], "value": 17634.102745207285, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [422.99577004229957, 430.4167852559783, 437.1682205469064, 445.87961250462376, 462.8333799832062, 19009.429717108473, 20834.479138021557, 21380.4654883628, 21534.353969380903, 21608.13567457302, 21701.45746356338, 22613.095476180933, 23343.299701008953, 23365.415864603394, 23659.76340236597, 6060.787872424466, 6184.659843708594, 6248.937510624904, 6266.091416744569, 6279.623222606659, 5969.522438204955, 6170.660613666247, 6181.6600086995195, 6237.688115594202, 6246.812595622138, 5973.492253158487, 6093.146959425684, 6164.075388691687, 6191.566590338678, 6227.688615569226, 6112.69436528174, 6156.984097623865, 6172.537059720539, 6173.783917562886, 6176.289726681399, 5400.000999815047, 5421.783128674848, 5495.807646732385, 5498.367687715924, 5504.504594586507, 27073.781679824457, 27255.45489090207, 27387.45225095507, 27416.862915685495, 27842.0, 1644.5806319388598, 1994.6509360861792, 2011.6119877284627, 2060.5054786851197, 2114.925977590792, 16075.115868627221, 16725.6654866902, 16748.58128546784, 16748.748768768477, 17409.390671326568, 1583.8812089093249, 1663.251536808429, 1685.6628674265196, 1715.3567412220418, 1741.364401993276, 143012.0, 153303.0, 158550.0, 162281.3771862278, 163341.3665863338, 12764.93617531925, 12933.676658083623, 12963.0, 13116.606501804961, 13155.0, 16441.0, 16634.916825415796, 16642.084685342423, 16659.83340166607, 16671.0, 6675.965225390072, 8741.825163496695, 8994.910050899407, 9198.724038278862, 9212.53937303132, 7134.0, 8621.69824056155, 8709.346798990102, 8781.20969112783, 8893.555322233862, 6569.67151642416, 7815.140334563193, 7907.169747176578, 7965.402594805413, 7966.362690984707, 2004.1883037369596, 2131.048497830485, 2162.3945295317335, 2165.242165242184, 2354.3525530479255, 884.5533005832142, 908.7728067983004, 922.3359181389388, 950.5722424908819, 975.6682727872558, 20493.692594611093, 21071.68392474114, 21111.894440528005, 21132.683009754866, 21158.365249042552, 904.9321300902327, 963.3545524498603, 976.9560369783377, 990.3810118675827, 997.4464172384396, 10774.892251077546, 11028.0, 11059.889401105886, 11069.50187241576, 11075.280106793032, 603834.0, 624559.0, 626351.0, 640351.0, 655512.0, 101542.93828246788, 108177.0, 146986.0, 160158.0, 160252.0, 972.8881178664402, 1179.504608064615, 1226.791445454275, 1241.422738426636, 1246.1028059796931, 21183.576328473653, 21316.893415533443, 21351.78648213498, 21417.571648567253, 21462.57074858463, 56541.15188272262, 57166.142507863246, 57849.0, 61591.38408615856, 62002.689986549776, 89478.55260723655, 89816.0, 89834.55082724545, 90269.0, 90425.40958608921, 7122.893156602551, 7734.690612375442, 7988.92011079905, 8353.707620233263, 8479.660813567634, 11559.76880462403, 12379.319137447526, 12910.741785164431, 13508.729825403634, 13527.661808454473, 9586.712398627773, 10845.24083314192, 11176.0, 11183.552657893919, 11370.658880233606, 9622.749042624415, 10161.796764064826, 10179.338343007978, 10441.738956526147, 10546.367217966947, 10718.464076795974, 11063.059639930374, 11697.415129243675, 11990.880091199326, 11991.400429978292, 8466.365022623451, 8555.57222138903, 8638.17937295956, 8726.607302671522, 8749.825003500022, 11410.801865804304, 11488.0, 11656.766864662828, 11670.066394688574, 11773.646790596296], "value": 10317.105404210804, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1341.476824038625, 1373.478078330235, 1382.4746596293407, 1393.477445957766, 1418.5106138382257, 10565.524551395196, 10897.291676041072, 11043.558257669694, 11054.839241879607, 11207.271527350737, 10795.730106747335, 11031.72420689481, 11199.832002519948, 11216.270942388759, 11241.044511216556, 2438.451348446599, 2487.701475822904, 2490.414752533153, 2499.2252401755513, 2499.562576549106, 2355.7408685044716, 2406.614941609343, 2454.6686197363397, 2460.2496238647204, 2462.249014050714, 2419.721732000825, 2422.697162854643, 2441.060191826142, 2454.4968281502247, 2466.7656572625574, 2364.775346342095, 2426.3448868805413, 2437.768412000857, 2440.804735621146, 2458.053649344997, 2347.471818840764, 2430.9270721878197, 2439.9756002439926, 2458.0045081741923, 2460.741622129686, 11139.275947063416, 11211.047060999825, 11212.215144939857, 11229.60696375631, 11240.988311052044, 6264.21697287839, 6495.447886929616, 6501.447376972963, 6519.902201466982, 6522.445592124675, 4043.6158564936286, 4080.285949958775, 4081.8571350002608, 4113.197926404352, 4179.017930786263, 1115.6597237842454, 1133.7732453509332, 1197.263682835059, 1242.2484396939813, 1247.070932155541, 13872.93063534686, 14330.64173395663, 15415.22923853814, 15552.377904883904, 15565.688686226325, 5641.153826925994, 5687.402822703557, 5919.1713160157615, 5950.8809823803285, 5976.701164941823, 12583.182093163916, 12599.811002834966, 12626.989840812714, 12668.36658167088, 12695.04787140968, 6351.0, 6404.167458230493, 6415.26224484181, 6417.550771446047, 6419.390157934989, 5642.210090587321, 5755.769769209269, 5836.241288632451, 5849.6782676952325, 5911.615744976562, 4451.888702782457, 4484.2376795944765, 4503.8606661835365, 4537.500874903758, 4541.772911354419, 1386.5077897346296, 1414.4907833180048, 1418.659521714781, 1423.274130193588, 1436.8491308412674, 745.1393640345301, 746.1344839985591, 768.2202564397141, 773.5281478298234, 775.2325198053886, 6308.369163083747, 6453.838654033687, 6615.669216539154, 6663.300353462817, 6690.297518760557, 571.7598608584321, 580.135597959038, 582.4670426559735, 583.6731430398991, 602.62637164958, 4031.605549950568, 4050.25070361984, 4161.97919010403, 4199.832006719758, 4268.466441694788, 13467.932660336635, 13996.86003139976, 14048.367823447968, 14062.71874562503, 14063.015588908678, 11993.74065723104, 12687.794659507332, 13175.868241317465, 13869.583912482642, 13964.2319672419, 7550.942867998485, 8903.33225008127, 9970.401775893324, 10001.199904007808, 10374.014468625468, 5801.564882633735, 6354.491640668828, 6507.381798729113, 6720.260771315249, 6726.730930762715, 11700.239484433485, 12020.218685785396, 12029.639110826689, 12088.335141567299, 12129.150959432754, 12309.707480714396, 12542.811857822322, 12683.87316126827, 12699.873001270238, 12747.490100396251, 8778.780530486534, 8925.419847709878, 9006.054364291655, 9023.323250756088, 9033.232175265177, 9909.603615855285, 10027.0, 10213.642522511676, 10257.58969641206, 10278.434686092336, 7391.0, 8473.49159050459, 8618.482891026559, 8725.996510401385, 8903.554822258991, 8289.751307460785, 8384.371172162235, 8436.409451338348, 8449.408541402043, 8596.441231319945, 7605.0, 7620.3522700571075, 7646.082470103401, 7708.653110609924, 7710.7686769397005, 5469.179623056573, 5917.940820591739, 5931.436513531207, 6001.309849367204, 6044.304904935812, 5903.881922361615, 6019.0, 6061.848453788691, 6093.207882975362, 6127.0], "value": 5165.981026245257, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [397.3999261115715, 397.5547386926639, 403.2720938705637, 408.4016915219203, 417.2322925816497, 5140.845774626762, 5508.669479831213, 6245.751529449401, 6256.09286653435, 6301.684915754211, 4964.4787297333805, 4996.975015124928, 6042.09368594711, 6161.845953851156, 6173.0, 3767.6420740029653, 4489.887752806173, 4544.250198717207, 4599.770011499429, 4797.066405547453, 4010.3182458981896, 4820.758962051901, 4844.442889067749, 4848.296996935443, 4857.34425852509, 4638.8608341749805, 4696.600788932945, 4740.668153229275, 4755.0, 4775.546323099317, 4734.455537613167, 4766.356541866873, 4777.829431789234, 4778.020505796321, 4811.663183577151, 4206.326987681956, 4227.894302642428, 4230.048239146198, 4235.0, 4237.957620423787, 5630.746616402272, 5931.436513531207, 5964.194833697482, 6007.579469437142, 6079.300880398767, 4154.91690166195, 4707.892790758083, 4841.685290456109, 5323.467653234684, 5349.465053494659, 6392.260527591365, 6428.97387488016, 6560.376764207393, 6567.408933196035, 6579.407853293179, 4255.787210639455, 4301.0, 4301.741895486281, 4315.611594956437, 4326.956730432718, 6228.221472316006, 6603.80188594343, 6886.003059112852, 6969.0940177776565, 6989.405900498464, 4284.700070995063, 4423.60187583119, 4453.888652783641, 4459.0, 4466.464024317038, 4029.992501874531, 4212.368144778307, 4327.480702315742, 4544.046060194082, 4545.204589196877, 4532.342810292489, 4708.670393072452, 5053.216751403538, 5057.786131328455, 5082.0, 5418.810341638024, 6577.736890524421, 6594.658896091914, 6615.503837212132, 6630.436412904861, 1304.8499422566335, 1545.590418539088, 1549.884083459907, 1551.8292987771335, 1560.173108252628, 951.7668171298076, 1008.5360734062414, 1018.4805749067881, 1020.1481762728205, 1029.763154474475, 5951.589606209492, 6265.937340626535, 6285.717142728588, 6294.65379404128, 6345.873082538324, 6719.790437721257, 6736.360045795642, 6824.2152152503095, 6824.7952561423235, 6832.419244364185, 5563.221149039137, 5822.737976791054, 6221.564490485713, 6249.9062514062325, 6303.842403939938, 3545.0679379738103, 3581.1047238190454, 3583.104223944014, 3600.4419315005694, 3602.6757591816863, 6032.185654936615, 6619.437347825393, 6833.965830170917, 6930.826729331807, 6974.9651251744435, 6046.065259117128, 6093.542984276197, 6475.838104047437, 7013.92986070143, 7073.540219885691, 5865.325487568899, 6399.712012959521, 6412.583182093149, 6697.430718388894, 6953.582785032914, 6097.74996125802, 6187.071939209155, 6779.830504237236, 6793.592384456949, 6818.318168183142, 6047.485963693135, 6420.967895160495, 6706.362895524917, 6743.831404214738, 6744.22441419243, 6646.833829154117, 6784.118064651564, 6833.4191593715095, 6884.449244060564, 7009.228984811769, 4405.845795397146, 4431.290993441163, 4442.178197033559, 4444.866654000385, 4447.844325448594, 5493.813588118961, 6413.903791443226, 6653.73385064592, 6771.729130834711, 6794.864102717819, 6516.967415162894, 6517.0, 6553.5084868635995, 6567.113439685581, 6588.82568752301, 5666.660000399825, 5854.297484301911, 6503.975651322158, 6511.34886511364, 6576.605403675795, 6293.0, 6319.704460585661, 6345.206849143857, 6356.0, 6392.625585498954, 6488.480921526361, 6497.018409385183, 6512.381323774234, 6526.543141980016, 6565.113709649328, 5330.360356757214, 5505.100740244609, 6355.459785918249, 6368.64972426521, 6421.949573952522], "value": 4778.209514454895, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [615.8029430582212, 673.3098573961691, 714.6605362452832, 729.5877829026599, 743.2381808646139, 12307.507699692012, 13701.3834377453, 14844.703105937888, 16029.118398488079, 16060.598485037879, 13382.397792099355, 14331.211783351911, 14712.0, 14815.407383704638, 15055.774163387558, 902.8871391076116, 925.065683659502, 928.614624930653, 929.3726734454216, 929.8930622978343, 911.7811725185974, 944.2729098594112, 948.1371951524114, 948.5304774136812, 951.3530799056639, 970.6942313171364, 977.9364341317792, 979.0503211884461, 980.0689345122126, 983.8475036369374, 979.6228452045942, 989.0, 990.5988074829705, 992.6476100984155, 994.1053052252958, 736.2747693521877, 736.7826491185114, 737.2811508778951, 737.9372753315974, 742.9702811887518, 16269.349226030945, 16508.917455412768, 16667.66664666712, 16834.66330673392, 17091.48725538236, 14479.42082316706, 14748.926255368655, 14755.452907387651, 14804.777928331083, 14930.47743328989, 11722.941385293105, 11850.3482308473, 11906.34515101669, 11943.581974630846, 12172.391380431032, 2959.215807810932, 2982.2246215984, 3010.9247268818235, 3087.7375423089065, 3113.081640915935, 103059.48470257675, 107121.0, 107210.46394767976, 108150.59662188074, 112379.43810280979, 10948.781024379627, 11045.171612129123, 11429.885701142883, 11720.06239500838, 11904.047676185884, 24500.387490312885, 24700.25899223026, 24937.251882443557, 25066.0, 25075.4984900301, 7198.208197098315, 7290.890636640454, 7318.194998550155, 7362.3373896349585, 7499.175090740015, 3478.930421391558, 3955.3869150281753, 4065.91868162641, 4090.3046482098116, 4090.6931980101613, 3483.1292176955762, 3922.235164143022, 3989.5611482736876, 4006.1186538961383, 4006.4390985262085, 792.7027364738224, 792.8374683189933, 801.5511313664366, 805.7099444200084, 815.4251252866715, 520.4509242748936, 528.2472476720734, 553.3581045986637, 562.1511517608359, 585.2413497440165, 9187.77030574241, 9507.714768556816, 9781.41311521311, 10028.69913902584, 10055.748606284755, 484.4646665434714, 544.2353493341782, 559.2048186798221, 581.201514706686, 592.2862950145064, 4041.656459201001, 4600.723956562617, 4646.581807637329, 4750.857474275777, 5157.303763991813, 75620.0, 94401.5279923596, 96953.0, 98244.50877745709, 101308.97382052465, 81630.59184704038, 82505.0, 82684.0, 84051.0, 85508.0, 50266.0, 75339.24660753542, 76484.0, 76569.23430765733, 79787.60106199431, 9298.628054877729, 10712.250142490262, 10746.46267686597, 10803.081738052038, 10874.0, 27491.587626186025, 36336.636633634385, 36805.079873003386, 36828.52685892535, 37215.813920930224, 46109.769451152526, 46423.071538568365, 46797.0, 46933.0, 47467.52532474631, 12718.300493472947, 13308.733825323246, 13436.664083397993, 13943.930280348533, 14094.78857817113, 14057.789133162807, 14111.435542578181, 14519.854801451851, 14836.851631483978, 15123.39506419731, 13625.114367566077, 13798.310084495533, 13953.093048951785, 14262.57212283633, 14320.355583998953, 13144.80282795778, 13285.269310188032, 13292.069555131047, 13771.242581658105, 13979.370928308048, 13095.738085238432, 13196.868031319947, 13242.933785331012, 13381.045758140139, 13547.322633868464, 9545.991830546043, 9616.95191524038, 9662.275329350467, 9859.35914165577, 9900.75248118774, 9095.95452022762, 10093.343932644355, 10936.56253749841, 11231.55073797039, 11455.541778329107], "value": 7341.761787507524, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1575.9999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 124.0, 115.0, 116.0, 119.0, 116.0, 116.0, 116.0, 115.0, 116.0], "value": 120.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 136.0, 146.0, 155.0, 113.0, 116.0, 116.0, 115.0, 138.0, 116.0], "value": 130.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [197.0, 212.0, 211.0, 211.0, 222.0, 203.0, 200.0, 201.0, 196.0, 198.0], "value": 205.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 56.0, 62.0, 89.0, 58.0, 64.0, 60.0, 63.0, 76.0, 59.0], "value": 67.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 70.0, 86.0, 71.0, 72.0, 71.0, 96.0, 102.0, 72.0, 83.0], "value": 80.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 130.0, 88.0, 95.0, 89.0, 103.0, 102.0, 135.0, 89.0, 91.0], "value": 104.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 98.0, 103.0, 96.0, 95.0, 121.0, 96.0, 96.0, 96.0, 97.0], "value": 99.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 93.0, 99.0, 90.0, 132.0, 147.0, 121.0, 91.0, 92.0, 89.0], "value": 104.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 68.0, 67.0, 70.0, 67.0, 67.0, 67.0, 67.0, 67.0], "value": 67.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 61.0, 66.0, 67.0, 65.0, 57.0, 56.0, 58.0, 64.0, 86.0], "value": 63.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 89.0, 101.0, 103.0, 107.0, 106.0, 89.0, 93.0, 107.0, 108.0], "value": 98.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 141.0, 144.0, 142.0, 140.0, 163.0, 160.0, 159.0, 171.0, 159.0], "value": 152.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [230.0, 233.0, 187.0, 212.0, 233.0, 203.0, 190.0, 185.0, 198.0, 185.0], "value": 205.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 70.0, 68.0, 70.0, 68.0, 69.0, 69.0, 87.0, 89.0, 98.0], "value": 76.0, "unit": "score"}]}]} 18:51:49 INFO - Return code: 0 18:51:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:51:49 ERROR - # TBPL SUCCESS # 18:51:49 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:51:49 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:51:49 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:51:49 INFO - 2017-03-24 18:51:49.271 screenresolution[2200:17735] starting screenresolution argv=screenresolution get 18:51:49 INFO - 2017-03-24 18:51:49.273 screenresolution[2200:17735] Display 0: 1600x1200x32@60 18:51:49 INFO - 2017-03-24 18:51:49.280 screenresolution[2201:17738] starting screenresolution argv=screenresolution list 18:51:49 INFO - Available Modes on Display 0 18:51:49 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:51:49 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:51:49 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:51:49 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:51:49 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:51:49 INFO - Intel Iris: 18:51:49 INFO - Chipset Model: Intel Iris 18:51:49 INFO - Type: GPU 18:51:49 INFO - Bus: Built-In 18:51:49 INFO - VRAM (Dynamic, Max): 1536 MB 18:51:49 INFO - Vendor: Intel (0x8086) 18:51:49 INFO - Device ID: 0x0a2e 18:51:49 INFO - Revision ID: 0x0009 18:51:49 INFO - Displays: 18:51:49 INFO - Display: 18:51:49 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:51:49 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:51:49 INFO - Display Serial Number: 1600x1200 60 18:51:49 INFO - Main Display: Yes 18:51:49 INFO - Mirror: Off 18:51:49 INFO - Online: Yes 18:51:49 INFO - Rotation: Supported 18:51:49 INFO - Return code: 0 18:51:49 INFO - Running post-action listener: _resource_record_post_action 18:51:49 INFO - [mozharness: 2017-03-25 01:51:49.518623Z] Finished run-tests step (success) 18:51:49 INFO - Running post-run listener: _resource_record_post_run 18:51:49 INFO - Total resource usage - Wall time: 1200s; CPU: 54.0%; Read bytes: 647168; Write bytes: 519566848; Read time: 9; Write time: 1711 18:51:49 INFO - TinderboxPrint: CPU usage
54.3% 18:51:49 INFO - TinderboxPrint: I/O read bytes / time
647,168 / 9 18:51:49 INFO - TinderboxPrint: I/O write bytes / time
519,566,848 / 1,711 18:51:49 INFO - TinderboxPrint: CPU idle
2,194.7 (45.7%) 18:51:49 INFO - TinderboxPrint: CPU system
967.8 (20.2%) 18:51:49 INFO - TinderboxPrint: CPU user
1,639.0 (34.1%) 18:51:49 INFO - TinderboxPrint: Swap in / out
212,361,216 / 0 18:51:49 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 204712448; Write bytes: 205572096; Read time: 15663; Write time: 456 18:51:49 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 647168; Write bytes: 303177216; Read time: 9; Write time: 1223 18:51:50 INFO - Running post-run listener: _upload_blobber_files 18:51:50 INFO - Blob upload gear active. 18:51:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:51:50 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:51:50 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:51:50 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:51:50 INFO - (blobuploader) - INFO - Open directory for files ... 18:51:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:51:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:51:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:51:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:51:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:51:51 INFO - (blobuploader) - INFO - Done attempting. 18:51:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:51:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:51:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:51:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:51:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:51:52 INFO - (blobuploader) - INFO - Done attempting. 18:51:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 18:51:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:51:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:51:53 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 18:51:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:51:53 INFO - (blobuploader) - INFO - Done attempting. 18:51:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:51:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:51:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:51:55 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:51:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:51:55 INFO - (blobuploader) - INFO - Done attempting. 18:51:55 INFO - (blobuploader) - INFO - Iteration through files over. 18:51:55 INFO - Return code: 0 18:51:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:51:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:51:55 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d3f15d339d2979b3ea3817bb958b5743ab54ae699d28bb9899a9e3546b11c21fad5be073ebdaf61f88aabd5fd9e81f15cad613d0a624a53bf567435f578cb920", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9bc9026cee39215df2862bee5b09ac2b06512b9ed9432e5ed97f1cc5d933d25044cb4847ed724b165e16663a4f97c9d43e7f98ea0b648bc1de752071f5cb53fa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d44aaacd042e1e97e5ff2b77e21b1d92c29f45e1ec0ba5f46cc182328044682a43e811c3a478a23721e466ef7d31e34646586a1307894288943808104150b267", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f63c936863bd4d6dd1c820c4cf80b5311966094c1afbd91956b719fa9a5e93a1cbdf3e6305f5fb61a79c92db58114599f865c97450328d63ad122aa320dce50e"} 18:51:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:51:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:51:55 INFO - Contents: 18:51:55 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d3f15d339d2979b3ea3817bb958b5743ab54ae699d28bb9899a9e3546b11c21fad5be073ebdaf61f88aabd5fd9e81f15cad613d0a624a53bf567435f578cb920", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9bc9026cee39215df2862bee5b09ac2b06512b9ed9432e5ed97f1cc5d933d25044cb4847ed724b165e16663a4f97c9d43e7f98ea0b648bc1de752071f5cb53fa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d44aaacd042e1e97e5ff2b77e21b1d92c29f45e1ec0ba5f46cc182328044682a43e811c3a478a23721e466ef7d31e34646586a1307894288943808104150b267", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f63c936863bd4d6dd1c820c4cf80b5311966094c1afbd91956b719fa9a5e93a1cbdf3e6305f5fb61a79c92db58114599f865c97450328d63ad122aa320dce50e"} 18:51:55 INFO - Running post-run listener: copy_logs_to_upload_dir 18:51:55 INFO - Copying logs to upload dir... 18:51:55 INFO - mkdir: /builds/slave/test/build/upload/logs 18:51:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1283.285791 ========= master_lag: 0.08 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2017-03-24 18:51:55.915829) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-24 18:51:55.919549) ========= 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.cM93edOhS7/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.RcqsQUQwRe/Listeners TMPDIR=/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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/d3f15d339d2979b3ea3817bb958b5743ab54ae699d28bb9899a9e3546b11c21fad5be073ebdaf61f88aabd5fd9e81f15cad613d0a624a53bf567435f578cb920", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9bc9026cee39215df2862bee5b09ac2b06512b9ed9432e5ed97f1cc5d933d25044cb4847ed724b165e16663a4f97c9d43e7f98ea0b648bc1de752071f5cb53fa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d44aaacd042e1e97e5ff2b77e21b1d92c29f45e1ec0ba5f46cc182328044682a43e811c3a478a23721e466ef7d31e34646586a1307894288943808104150b267", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f63c936863bd4d6dd1c820c4cf80b5311966094c1afbd91956b719fa9a5e93a1cbdf3e6305f5fb61a79c92db58114599f865c97450328d63ad122aa320dce50e"} build_url:https://queue.taskcluster.net/v1/task/TN3sA-yTSn2eIb8T2ruPxA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011228 build_url: 'https://queue.taskcluster.net/v1/task/TN3sA-yTSn2eIb8T2ruPxA/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/d3f15d339d2979b3ea3817bb958b5743ab54ae699d28bb9899a9e3546b11c21fad5be073ebdaf61f88aabd5fd9e81f15cad613d0a624a53bf567435f578cb920", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9bc9026cee39215df2862bee5b09ac2b06512b9ed9432e5ed97f1cc5d933d25044cb4847ed724b165e16663a4f97c9d43e7f98ea0b648bc1de752071f5cb53fa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d44aaacd042e1e97e5ff2b77e21b1d92c29f45e1ec0ba5f46cc182328044682a43e811c3a478a23721e466ef7d31e34646586a1307894288943808104150b267", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f63c936863bd4d6dd1c820c4cf80b5311966094c1afbd91956b719fa9a5e93a1cbdf3e6305f5fb61a79c92db58114599f865c97450328d63ad122aa320dce50e"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-24 18:51:55.959193) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-24 18:51:55.959520) ========= 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.cM93edOhS7/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.RcqsQUQwRe/Listeners TMPDIR=/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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.005345 ========= master_lag: 0.37 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-24 18:51:56.338263) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-24 18:51:56.338996) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-24 18:51:56.339357) ========= ========= Total master_lag: 0.56 =========