builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0305 starttime: 1491306691.71 results: success (0) buildid: 20170404033427 builduid: a3fd512aab694e85b874fa6e5ce6594b revision: 916a4ee676a33355fc717f15ecb80815ba95051e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-04 04:51:31.706897) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-04 04:51:31.707290) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-04 04:51:31.707576) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-04 04:51:31.735643) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 04:51:31.736001) ========= 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.n9e71pItTD/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.kVpnxlNZJP/Listeners TMPDIR=/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/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-04-04 04:51:31-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 22.8M=0.001s 2017-04-04 04:51:31 (22.8 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.096319 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 04:51:31.889540) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 04:51:31.889950) ========= 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.n9e71pItTD/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.kVpnxlNZJP/Listeners TMPDIR=/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/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.028244 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 04:51:31.939602) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 04:51:31.939949) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 916a4ee676a33355fc717f15ecb80815ba95051e --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 916a4ee676a33355fc717f15ecb80815ba95051e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.n9e71pItTD/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.kVpnxlNZJP/Listeners TMPDIR=/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/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-04-04 04:51:32,051 truncating revision to first 12 chars 2017-04-04 04:51:32,051 Setting DEBUG logging. 2017-04-04 04:51:32,051 attempt 1/10 2017-04-04 04:51:32,051 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/916a4ee676a3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-04 04:51:32,415 unpacking tar archive at: mozilla-central-916a4ee676a3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.646232 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 04:51:32.615511) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-04 04:51:32.615841) ========= script_repo_revision: 916a4ee676a33355fc717f15ecb80815ba95051e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-04 04:51:32.616222) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-04 04:51:32.616501) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-04 04:51:32.636060) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 30 secs) (at 2017-04-04 04:51:32.636423) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.n9e71pItTD/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.kVpnxlNZJP/Listeners TMPDIR=/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/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 04:51:32 INFO - MultiFileLogger online at 20170404 04:51:32 in /builds/slave/test 04:51:32 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:51:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:51:32 INFO - {'append_to_log': False, 04:51:32 INFO - 'base_work_dir': '/builds/slave/test', 04:51:32 INFO - 'blob_upload_branch': 'Firefox', 04:51:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:51:32 INFO - 'branch': 'Firefox', 04:51:32 INFO - 'buildbot_json_path': 'buildprops.json', 04:51:32 INFO - 'config_files': ('talos/mac_config.py',), 04:51:32 INFO - 'default_actions': ('clobber', 04:51:32 INFO - 'read-buildbot-config', 04:51:32 INFO - 'download-and-extract', 04:51:32 INFO - 'populate-webroot', 04:51:32 INFO - 'create-virtualenv', 04:51:32 INFO - 'install', 04:51:32 INFO - 'run-tests'), 04:51:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:51:32 INFO - 'download_minidump_stackwalk': True, 04:51:32 INFO - 'download_symbols': 'ondemand', 04:51:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:51:32 INFO - 'tooltool.py': '/tools/tooltool.py', 04:51:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:51:32 INFO - '/tools/misc-python/virtualenv.py')}, 04:51:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:51:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:51:32 INFO - 'gecko_profile': False, 04:51:32 INFO - 'gecko_profile_interval': 0, 04:51:32 INFO - 'installer_path': 'installer.exe', 04:51:32 INFO - 'log_level': 'info', 04:51:32 INFO - 'log_name': 'talos', 04:51:32 INFO - 'log_to_console': True, 04:51:32 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:51:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:51:32 INFO - 'opt_config_files': (), 04:51:32 INFO - 'pip_index': False, 04:51:32 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:51:32 INFO - 'cmd': ('bash', 04:51:32 INFO - '-c', 04:51:32 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:51:32 INFO - 'enabled': True, 04:51:32 INFO - 'halt_on_failure': False, 04:51:32 INFO - 'name': 'check_screen_resolution'},), 04:51:32 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:51:32 INFO - 'cmd': ('bash', 04:51:32 INFO - '-c', 04:51:32 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:51:32 INFO - 'enabled': True, 04:51:32 INFO - 'halt_on_failure': False, 04:51:32 INFO - 'name': 'check_screen_resolution'},), 04:51:32 INFO - 'run_cmd_checks_enabled': True, 04:51:32 INFO - 'suite': 'dromaeojs', 04:51:32 INFO - 'system_bits': '32', 04:51:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:51:32 INFO - 'title': 't-yosemite-r7-0305', 04:51:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:51:32 INFO - 'use_talos_json': True, 04:51:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:51:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:51:32 INFO - 'work_dir': 'build'} 04:51:32 INFO - [mozharness: 2017-04-04 11:51:32.852763Z] Running clobber step. 04:51:32 INFO - Running pre-action listener: _resource_record_pre_action 04:51:32 INFO - Running main action method: clobber 04:51:32 INFO - rmtree: /builds/slave/test/build 04:51:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:51:35 INFO - Running post-action listener: _resource_record_post_action 04:51:35 INFO - [mozharness: 2017-04-04 11:51:35.341209Z] Finished clobber step (success) 04:51:35 INFO - [mozharness: 2017-04-04 11:51:35.341341Z] Running read-buildbot-config step. 04:51:35 INFO - Running pre-action listener: _resource_record_pre_action 04:51:35 INFO - Running main action method: read_buildbot_config 04:51:35 INFO - Using buildbot properties: 04:51:35 INFO - { 04:51:35 INFO - "project": "", 04:51:35 INFO - "product": "firefox", 04:51:35 INFO - "script_repo_revision": "production", 04:51:35 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 04:51:35 INFO - "repository": "", 04:51:35 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 04:51:35 INFO - "buildid": "20170404033427", 04:51:35 INFO - "pgo_build": "False", 04:51:35 INFO - "basedir": "/builds/slave/test", 04:51:35 INFO - "buildnumber": 67, 04:51:35 INFO - "slavename": "t-yosemite-r7-0305", 04:51:35 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 04:51:35 INFO - "platform": "yosemite_r7", 04:51:35 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:51:35 INFO - "branch": "mozilla-central", 04:51:35 INFO - "repo_path": "mozilla-central", 04:51:35 INFO - "revision": "916a4ee676a33355fc717f15ecb80815ba95051e", 04:51:35 INFO - "stage_platform": "macosx64", 04:51:35 INFO - "builduid": "a3fd512aab694e85b874fa6e5ce6594b", 04:51:35 INFO - "slavebuilddir": "test" 04:51:35 INFO - } 04:51:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/DD5TEWs3QH215aOaprSWcQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 04:51:35 INFO - Running post-action listener: _resource_record_post_action 04:51:35 INFO - [mozharness: 2017-04-04 11:51:35.344662Z] Finished read-buildbot-config step (success) 04:51:35 INFO - [mozharness: 2017-04-04 11:51:35.344769Z] Running download-and-extract step. 04:51:35 INFO - Running pre-action listener: _resource_record_pre_action 04:51:35 INFO - Running main action method: download_and_extract 04:51:35 INFO - mkdir: /builds/slave/test/build/tests 04:51:35 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')]} 04:51:35 INFO - trying https://queue.taskcluster.net/v1/task/DD5TEWs3QH215aOaprSWcQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 04:51:35 INFO - Downloading https://queue.taskcluster.net/v1/task/DD5TEWs3QH215aOaprSWcQ/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 04:51:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DD5TEWs3QH215aOaprSWcQ/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 04:51:36 INFO - Downloaded 1325 bytes. 04:51:36 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 04:51:36 INFO - Using the following test package requirements: 04:51:36 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:51:36 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 04:51:36 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 04:51:36 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:51:36 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 04:51:36 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:51:36 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 04:51:36 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:51:36 INFO - u'jsshell-mac.zip'], 04:51:36 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:51:36 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 04:51:36 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 04:51:36 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:51:36 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 04:51:36 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:51:36 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 04:51:36 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:51:36 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 04:51:36 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:51:36 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 04:51:36 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:51:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DD5TEWs3QH215aOaprSWcQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 04:51:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DD5TEWs3QH215aOaprSWcQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:51:36 INFO - Fetch https://queue.taskcluster.net/v1/task/DD5TEWs3QH215aOaprSWcQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 04:51:38 INFO - Expected file size: 52517206 04:51:38 INFO - Obtained file size: 52517206 04:51: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 04:51:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DD5TEWs3QH215aOaprSWcQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 04:51:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DD5TEWs3QH215aOaprSWcQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:51:54 INFO - Fetch https://queue.taskcluster.net/v1/task/DD5TEWs3QH215aOaprSWcQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 04:51:56 INFO - Expected file size: 52517206 04:51:56 INFO - Obtained file size: 52517206 04:52:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DD5TEWs3QH215aOaprSWcQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 04:52:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DD5TEWs3QH215aOaprSWcQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:52:12 INFO - Fetch https://queue.taskcluster.net/v1/task/DD5TEWs3QH215aOaprSWcQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 04:52:13 INFO - Expected file size: 14404152 04:52:13 INFO - Obtained file size: 14404152 04:52:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:52:13 INFO - trying https://queue.taskcluster.net/v1/task/DD5TEWs3QH215aOaprSWcQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:52:13 INFO - Downloading https://queue.taskcluster.net/v1/task/DD5TEWs3QH215aOaprSWcQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 04:52:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DD5TEWs3QH215aOaprSWcQ/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 04:52:16 INFO - Downloaded 75580833 bytes. 04:52:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DD5TEWs3QH215aOaprSWcQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:52:16 INFO - mkdir: /builds/slave/test/properties 04:52:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:52:16 INFO - Writing to file /builds/slave/test/properties/build_url 04:52:16 INFO - Contents: 04:52:16 INFO - build_url:https://queue.taskcluster.net/v1/task/DD5TEWs3QH215aOaprSWcQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:52:16 INFO - Running post-action listener: _resource_record_post_action 04:52:16 INFO - Running post-action listener: set_extra_try_arguments 04:52:16 INFO - [mozharness: 2017-04-04 11:52:16.749710Z] Finished download-and-extract step (success) 04:52:16 INFO - [mozharness: 2017-04-04 11:52:16.749875Z] Running populate-webroot step. 04:52:16 INFO - Running pre-action listener: _resource_record_pre_action 04:52:16 INFO - Running main action method: populate_webroot 04:52:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:52:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:52:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:52:16 INFO - '--tppagecycles', 04:52:16 INFO - '7'], 04:52:16 INFO - 'tests': ['tsvgm']}}, 04:52:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:52:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:52:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:52:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:52:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:52:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:52:16 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:52:16 INFO - 'talos_options': ['--disable-e10s'], 04:52:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:52:16 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:52:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:52:16 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:52:16 INFO - 'talos_options': ['--disable-e10s'], 04:52:16 INFO - 'tests': ['damp', 'tps']}, 04:52:16 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:52:16 INFO - 'tests': ['damp', 'tps']}, 04:52:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:52:16 INFO - 'tests': ['dromaeo_dom']}, 04:52:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:52:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:52:16 INFO - 'tests': ['basic_compositor_video']}, 04:52:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:52:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:52:16 INFO - 'tests': ['a11yr', 04:52:16 INFO - 'ts_paint', 04:52:16 INFO - 'tpaint', 04:52:16 INFO - 'sessionrestore', 04:52:16 INFO - 'sessionrestore_no_auto_restore', 04:52:16 INFO - 'tabpaint']}, 04:52:16 INFO - 'other-e10s': {'tests': ['a11yr', 04:52:16 INFO - 'ts_paint', 04:52:16 INFO - 'tpaint', 04:52:16 INFO - 'sessionrestore', 04:52:16 INFO - 'sessionrestore_no_auto_restore', 04:52:16 INFO - 'tabpaint']}, 04:52:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:52:16 INFO - 'ts_paint', 04:52:16 INFO - 'tpaint', 04:52:16 INFO - 'sessionrestore', 04:52:16 INFO - 'sessionrestore_no_auto_restore', 04:52:16 INFO - 'tabpaint']}, 04:52:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:52:16 INFO - 'ts_paint', 04:52:16 INFO - 'tpaint', 04:52:16 INFO - 'sessionrestore', 04:52:16 INFO - 'sessionrestore_no_auto_restore', 04:52:16 INFO - 'tabpaint']}, 04:52:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:52:16 INFO - 'tests': ['a11yr', 04:52:16 INFO - 'ts_paint', 04:52:16 INFO - 'tpaint', 04:52:16 INFO - 'sessionrestore', 04:52:16 INFO - 'sessionrestore_no_auto_restore', 04:52:16 INFO - 'tabpaint']}, 04:52:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:52:16 INFO - 'tests': ['a11yr', 04:52:16 INFO - 'ts_paint', 04:52:16 INFO - 'tpaint', 04:52:16 INFO - 'sessionrestore', 04:52:16 INFO - 'sessionrestore_no_auto_restore', 04:52:16 INFO - 'tabpaint']}, 04:52:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:52:16 INFO - 'tests': ['tsvgx', 04:52:16 INFO - 'tsvgr_opacity', 04:52:16 INFO - 'tart', 04:52:16 INFO - 'tscrollx', 04:52:16 INFO - 'cart', 04:52:16 INFO - 'tsvg_static']}, 04:52:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:52:16 INFO - 'tsvgr_opacity', 04:52:16 INFO - 'tart', 04:52:16 INFO - 'tscrollx', 04:52:16 INFO - 'cart', 04:52:16 INFO - 'tsvg_static']}, 04:52:16 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:52:16 INFO - 'talos_options': ['--disable-e10s'], 04:52:16 INFO - 'tests': ['tp5o']}, 04:52:16 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:52:16 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:52:16 INFO - 'talos_options': ['--disable-e10s', 04:52:16 INFO - '--xperf_path', 04:52:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:52:16 INFO - 'tests': ['tp5n']}, 04:52:16 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:52:16 INFO - 'talos_options': ['--xperf_path', 04:52:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:52:16 INFO - 'tests': ['tp5n']}}, 04:52:16 INFO - 'talos.zip': {'path': '', 04:52:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:52:16 INFO - Running post-action listener: _resource_record_post_action 04:52:16 INFO - [mozharness: 2017-04-04 11:52:16.768171Z] Finished populate-webroot step (success) 04:52:16 INFO - [mozharness: 2017-04-04 11:52:16.768308Z] Running create-virtualenv step. 04:52:16 INFO - Running pre-action listener: _resource_record_pre_action 04:52:16 INFO - Running main action method: create_virtualenv 04:52:16 INFO - Creating virtualenv /builds/slave/test/build/venv 04:52:16 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 04:52:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:52:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:52:16 INFO - Using real prefix '/tools/python27' 04:52:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:52:17 INFO - Installing distribute.............................................................................................................................................................................................done. 04:52:20 INFO - Installing pip.................done. 04:52:20 INFO - Return code: 0 04:52:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:52:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:52:20 INFO - Reading from file tmpfile_stdout 04:52:20 INFO - Output received: 04:52:20 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) 04:52:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:52:20 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')]} 04:52:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:21 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')]} 04:52:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:21 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 0x109efbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109efe768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85fbd639d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109cd9d30>, '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 0x109c00db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109ccebe8>, '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.n9e71pItTD/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.kVpnxlNZJP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/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 04:52:21 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 04:52:21 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 04:52:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.n9e71pItTD/Render', 04:52:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:52:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:52:21 INFO - 'HOME': '/Users/cltbld', 04:52:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:52:21 INFO - 'LOGNAME': 'cltbld', 04:52:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:21 INFO - 'MOZ_NO_REMOTE': '1', 04:52:21 INFO - 'NO_EM_RESTART': '1', 04:52:21 INFO - 'PAGER': '/bin/cat', 04:52:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:52:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:21 INFO - 'PWD': '/builds/slave/test', 04:52:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:52:21 INFO - 'SHELL': '/bin/bash', 04:52:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kVpnxlNZJP/Listeners', 04:52:21 INFO - 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/', 04:52:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:52:21 INFO - 'USER': 'cltbld', 04:52:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:52:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:52:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:21 INFO - 'XPC_FLAGS': '0x0', 04:52:21 INFO - 'XPC_SERVICE_NAME': '0', 04:52:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:52:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:21 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 04:52:21 INFO - Cleaning up... 04:52:21 INFO - Return code: 0 04:52:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:52:21 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')]} 04:52:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:21 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')]} 04:52:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:22 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 0x109efbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109efe768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85fbd639d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109cd9d30>, '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 0x109c00db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109ccebe8>, '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.n9e71pItTD/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.kVpnxlNZJP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/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 04:52:22 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 04:52:22 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 04:52:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.n9e71pItTD/Render', 04:52:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:52:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:52:22 INFO - 'HOME': '/Users/cltbld', 04:52:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:52:22 INFO - 'LOGNAME': 'cltbld', 04:52:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:22 INFO - 'MOZ_NO_REMOTE': '1', 04:52:22 INFO - 'NO_EM_RESTART': '1', 04:52:22 INFO - 'PAGER': '/bin/cat', 04:52:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:52:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:22 INFO - 'PWD': '/builds/slave/test', 04:52:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:52:22 INFO - 'SHELL': '/bin/bash', 04:52:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kVpnxlNZJP/Listeners', 04:52:22 INFO - 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/', 04:52:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:52:22 INFO - 'USER': 'cltbld', 04:52:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:52:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:52:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:22 INFO - 'XPC_FLAGS': '0x0', 04:52:22 INFO - 'XPC_SERVICE_NAME': '0', 04:52:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:52:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:22 INFO - Downloading/unpacking psutil>=3.1.1 04:52:22 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 04:52:22 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 04:52:22 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 04:52:22 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 04:52:22 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 04:52:22 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 04:52:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:52:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:52:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:52:26 INFO - Installing collected packages: psutil 04:52:26 INFO - Running setup.py install for psutil 04:52:26 INFO - building 'psutil._psutil_osx' extension 04:52:26 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 04:52:26 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 04:52:26 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 04:52:26 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 04:52:27 INFO - building 'psutil._psutil_posix' extension 04:52:27 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 04:52:27 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:52:27 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:52:27 INFO - ^ 04:52:27 INFO - 1 warning generated. 04:52:27 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 04:52:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:52:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:52:27 INFO - Successfully installed psutil 04:52:27 INFO - Cleaning up... 04:52:27 INFO - Return code: 0 04:52:27 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:52: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')]} 04:52:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52: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')]} 04:52:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:27 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 0x109efbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109efe768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85fbd639d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109cd9d30>, '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 0x109c00db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109ccebe8>, '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.n9e71pItTD/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.kVpnxlNZJP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/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 04:52:27 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 04:52:27 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 04:52:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.n9e71pItTD/Render', 04:52:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:52:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:52:27 INFO - 'HOME': '/Users/cltbld', 04:52:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:52:27 INFO - 'LOGNAME': 'cltbld', 04:52:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:27 INFO - 'MOZ_NO_REMOTE': '1', 04:52:27 INFO - 'NO_EM_RESTART': '1', 04:52:27 INFO - 'PAGER': '/bin/cat', 04:52:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:52:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:27 INFO - 'PWD': '/builds/slave/test', 04:52:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:52:27 INFO - 'SHELL': '/bin/bash', 04:52:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kVpnxlNZJP/Listeners', 04:52:27 INFO - 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/', 04:52:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:52:27 INFO - 'USER': 'cltbld', 04:52:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:52:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:52:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:27 INFO - 'XPC_FLAGS': '0x0', 04:52:27 INFO - 'XPC_SERVICE_NAME': '0', 04:52:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:52:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:27 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:52:27 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 04:52:27 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 04:52:27 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 04:52:27 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 04:52:27 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 04:52:27 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 04:52:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:52:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:52:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:52:30 INFO - Installing collected packages: mozsystemmonitor 04:52:30 INFO - Running setup.py install for mozsystemmonitor 04:52:30 INFO - Successfully installed mozsystemmonitor 04:52:30 INFO - Cleaning up... 04:52:30 INFO - Return code: 0 04:52:30 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:52:30 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')]} 04:52:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:30 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')]} 04:52:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:30 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 0x109efbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109efe768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85fbd639d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109cd9d30>, '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 0x109c00db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109ccebe8>, '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.n9e71pItTD/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.kVpnxlNZJP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/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 04:52:30 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 04:52:30 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 04:52:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.n9e71pItTD/Render', 04:52:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:52:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:52:30 INFO - 'HOME': '/Users/cltbld', 04:52:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:52:30 INFO - 'LOGNAME': 'cltbld', 04:52:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:30 INFO - 'MOZ_NO_REMOTE': '1', 04:52:30 INFO - 'NO_EM_RESTART': '1', 04:52:30 INFO - 'PAGER': '/bin/cat', 04:52:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:52:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:30 INFO - 'PWD': '/builds/slave/test', 04:52:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:52:30 INFO - 'SHELL': '/bin/bash', 04:52:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kVpnxlNZJP/Listeners', 04:52:30 INFO - 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/', 04:52:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:52:30 INFO - 'USER': 'cltbld', 04:52:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:52:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:52:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:30 INFO - 'XPC_FLAGS': '0x0', 04:52:30 INFO - 'XPC_SERVICE_NAME': '0', 04:52:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:52:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:30 INFO - Downloading/unpacking jsonschema==2.5.1 04:52:30 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 04:52:30 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 04:52:30 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 04:52:30 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 04:52:30 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 04:52:30 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 04:52:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:52:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:52:33 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 04:52:33 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 04:52:33 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 04:52:33 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 04:52:33 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 04:52:33 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 04:52:33 INFO - Downloading functools32-3.2.3-2.tar.gz 04:52:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:52:33 INFO - warning: no files found matching '*.txt' 04:52:33 INFO - no previously-included directories found matching 'build' 04:52:33 INFO - no previously-included directories found matching 'dist' 04:52:33 INFO - no previously-included directories found matching '.git*' 04:52:33 INFO - Installing collected packages: jsonschema, functools32 04:52:33 INFO - Running setup.py install for functools32 04:52:34 INFO - warning: no files found matching '*.txt' 04:52:34 INFO - no previously-included directories found matching 'build' 04:52:34 INFO - no previously-included directories found matching 'dist' 04:52:34 INFO - no previously-included directories found matching '.git*' 04:52:34 INFO - Successfully installed jsonschema functools32 04:52:34 INFO - Cleaning up... 04:52:34 INFO - Return code: 0 04:52:34 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:52: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')]} 04:52:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52: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')]} 04:52:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:34 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 0x109efbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109efe768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85fbd639d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109cd9d30>, '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 0x109c00db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109ccebe8>, '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.n9e71pItTD/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.kVpnxlNZJP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/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 04:52:34 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 04:52:34 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 04:52:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.n9e71pItTD/Render', 04:52:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:52:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:52:34 INFO - 'HOME': '/Users/cltbld', 04:52:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:52:34 INFO - 'LOGNAME': 'cltbld', 04:52:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:34 INFO - 'MOZ_NO_REMOTE': '1', 04:52:34 INFO - 'NO_EM_RESTART': '1', 04:52:34 INFO - 'PAGER': '/bin/cat', 04:52:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:52:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:34 INFO - 'PWD': '/builds/slave/test', 04:52:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:52:34 INFO - 'SHELL': '/bin/bash', 04:52:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kVpnxlNZJP/Listeners', 04:52:34 INFO - 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/', 04:52:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:52:34 INFO - 'USER': 'cltbld', 04:52:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:52:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:52:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:34 INFO - 'XPC_FLAGS': '0x0', 04:52:34 INFO - 'XPC_SERVICE_NAME': '0', 04:52:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:52:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:34 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:52:34 INFO - Cleaning up... 04:52:34 INFO - Return code: 0 04:52:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:52: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')]} 04:52:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52: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')]} 04:52:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:34 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 0x109efbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109efe768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85fbd639d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109cd9d30>, '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 0x109c00db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109ccebe8>, '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.n9e71pItTD/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.kVpnxlNZJP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/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 04:52:34 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 04:52:34 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 04:52:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.n9e71pItTD/Render', 04:52:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:52:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:52:34 INFO - 'HOME': '/Users/cltbld', 04:52:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:52:34 INFO - 'LOGNAME': 'cltbld', 04:52:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:34 INFO - 'MOZ_NO_REMOTE': '1', 04:52:34 INFO - 'NO_EM_RESTART': '1', 04:52:34 INFO - 'PAGER': '/bin/cat', 04:52:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:52:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:34 INFO - 'PWD': '/builds/slave/test', 04:52:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:52:34 INFO - 'SHELL': '/bin/bash', 04:52:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kVpnxlNZJP/Listeners', 04:52:34 INFO - 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/', 04:52:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:52:34 INFO - 'USER': 'cltbld', 04:52:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:52:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:52:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:34 INFO - 'XPC_FLAGS': '0x0', 04:52:34 INFO - 'XPC_SERVICE_NAME': '0', 04:52:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:52:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:34 INFO - Downloading/unpacking blobuploader==1.2.4 04:52:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:37 INFO - Downloading blobuploader-1.2.4.tar.gz 04:52:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:52:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:52:37 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 04:52:37 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 04:52:37 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 04:52:37 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 04:52:37 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 04:52:37 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 04:52:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:52:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:52:38 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 04:52:38 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 04:52:38 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 04:52:38 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 04:52:38 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 04:52:38 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 04:52:38 INFO - Downloading docopt-0.6.1.tar.gz 04:52:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:52:38 INFO - Installing collected packages: blobuploader, requests, docopt 04:52:38 INFO - Running setup.py install for blobuploader 04:52:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:52:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:52:38 INFO - Running setup.py install for requests 04:52:39 INFO - Running setup.py install for docopt 04:52:39 INFO - Successfully installed blobuploader requests docopt 04:52:39 INFO - Cleaning up... 04:52:39 INFO - Return code: 0 04:52:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:52:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:52:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:52:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:39 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 0x109efbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109efe768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85fbd639d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109cd9d30>, '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 0x109c00db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109ccebe8>, '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.n9e71pItTD/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.kVpnxlNZJP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/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 04:52:39 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 04:52:39 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 04:52:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.n9e71pItTD/Render', 04:52:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:52:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:52:39 INFO - 'HOME': '/Users/cltbld', 04:52:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:52:39 INFO - 'LOGNAME': 'cltbld', 04:52:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:39 INFO - 'MOZ_NO_REMOTE': '1', 04:52:39 INFO - 'NO_EM_RESTART': '1', 04:52:39 INFO - 'PAGER': '/bin/cat', 04:52:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:52:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:39 INFO - 'PWD': '/builds/slave/test', 04:52:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:52:39 INFO - 'SHELL': '/bin/bash', 04:52:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kVpnxlNZJP/Listeners', 04:52:39 INFO - 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/', 04:52:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:52:39 INFO - 'USER': 'cltbld', 04:52:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:52:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:52:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:39 INFO - 'XPC_FLAGS': '0x0', 04:52:39 INFO - 'XPC_SERVICE_NAME': '0', 04:52:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:52:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:52:39 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-a2NuiP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:52:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:52:39 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-_2rNu_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:52:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:52:40 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-Tf3KhJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:52:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:52:40 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-mxF7BK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:52:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:52:40 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-gpIASW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:52:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:52:40 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-nfAhrX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:52:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:52:40 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-XVaMfF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:52:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:52:40 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-qtMwM1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:52:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:52:40 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-ttuZvj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:52:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:52:40 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-lcYFb1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:52:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:52:40 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-xZmomV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:52:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:52:40 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-XCWDYp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:52:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:52:41 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-9_9_Dd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:52:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:52:41 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-ZnZJMU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:52:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:52:41 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-hV86EX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:52:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:52:41 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-pujaj7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:52:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:52:41 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-lkUCVh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:52:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:52:41 INFO - Running setup.py install for manifestparser 04:52:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:52:41 INFO - Running setup.py install for mozcrash 04:52:41 INFO - Running setup.py install for mozdebug 04:52:42 INFO - Running setup.py install for mozdevice 04:52:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:52:42 INFO - Running setup.py install for mozfile 04:52:42 INFO - Running setup.py install for mozhttpd 04:52:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:52:42 INFO - Running setup.py install for mozinfo 04:52:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:52:42 INFO - Running setup.py install for mozInstall 04:52:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:52:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:52:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:52:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:52:42 INFO - Running setup.py install for mozleak 04:52:42 INFO - Running setup.py install for mozlog 04:52:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:52:43 INFO - Running setup.py install for moznetwork 04:52:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:52:43 INFO - Running setup.py install for mozprocess 04:52:43 INFO - Running setup.py install for mozprofile 04:52:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:52:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:52:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:52:43 INFO - Running setup.py install for mozrunner 04:52:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:52:43 INFO - Running setup.py install for mozscreenshot 04:52:43 INFO - Running setup.py install for moztest 04:52:44 INFO - Running setup.py install for mozversion 04:52:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:52:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:52:44 INFO - Cleaning up... 04:52:44 INFO - Return code: 0 04:52:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:52:44 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')]} 04:52:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:44 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')]} 04:52:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:44 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 0x109efbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109efe768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85fbd639d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109cd9d30>, '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 0x109c00db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109ccebe8>, '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.n9e71pItTD/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.kVpnxlNZJP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/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 04:52:44 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 04:52:44 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 04:52:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.n9e71pItTD/Render', 04:52:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:52:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:52:44 INFO - 'HOME': '/Users/cltbld', 04:52:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:52:44 INFO - 'LOGNAME': 'cltbld', 04:52:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:44 INFO - 'MOZ_NO_REMOTE': '1', 04:52:44 INFO - 'NO_EM_RESTART': '1', 04:52:44 INFO - 'PAGER': '/bin/cat', 04:52:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:52:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:44 INFO - 'PWD': '/builds/slave/test', 04:52:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:52:44 INFO - 'SHELL': '/bin/bash', 04:52:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kVpnxlNZJP/Listeners', 04:52:44 INFO - 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/', 04:52:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:52:44 INFO - 'USER': 'cltbld', 04:52:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:52:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:52:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:44 INFO - 'XPC_FLAGS': '0x0', 04:52:44 INFO - 'XPC_SERVICE_NAME': '0', 04:52:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:52:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:52:44 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-L7lj6M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:52:44 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)) 04:52:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:52:44 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-1tDEXR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:52:44 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)) 04:52:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:52:44 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-M677up-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:52:44 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)) 04:52:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:52:44 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-mlsSNL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:52:44 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)) 04:52:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:52:44 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-MONjfd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:52:44 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)) 04:52:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:52:44 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-33E9hd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:52:45 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)) 04:52:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:52:45 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-nMO1TJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:52:45 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)) 04:52:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:52:45 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-VVn5ND-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:52:45 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)) 04:52:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:52:45 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-55SNNM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:52:45 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)) 04:52:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:52:45 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-UJm3rF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:52:45 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)) 04:52:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:52:45 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-hHsjk6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:52:45 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)) 04:52:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:52:45 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-tClRJh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:52:45 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)) 04:52:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:52:45 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-uJ4GBi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:52:45 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)) 04:52:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:52:45 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-XVWxK9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:52:45 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)) 04:52:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:52:45 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-rTStxC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:52:46 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)) 04:52:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:52:46 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-VsvUKi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:52:46 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)) 04:52:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:52:46 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-o_ZLWC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:52:46 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)) 04:52:46 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)) 04:52:46 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)) 04:52:46 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)) 04:52:46 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)) 04:52:46 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)) 04:52:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:52:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:48 INFO - Downloading blessings-1.6.tar.gz 04:52:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:52:49 INFO - Installing collected packages: blessings 04:52:49 INFO - Running setup.py install for blessings 04:52:49 INFO - Successfully installed blessings 04:52:49 INFO - Cleaning up... 04:52:49 INFO - Return code: 0 04:52:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:52:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:52:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:52:49 INFO - Reading from file tmpfile_stdout 04:52:49 INFO - Current package versions: 04:52:49 INFO - blessings == 1.6 04:52:49 INFO - blobuploader == 1.2.4 04:52:49 INFO - docopt == 0.6.1 04:52:49 INFO - functools32 == 3.2.3-2 04:52:49 INFO - jsonschema == 2.5.1 04:52:49 INFO - manifestparser == 1.1 04:52:49 INFO - mozInstall == 1.12 04:52:49 INFO - mozcrash == 1.0 04:52:49 INFO - mozdebug == 0.1 04:52:49 INFO - mozdevice == 0.49 04:52:49 INFO - mozfile == 1.2 04:52:49 INFO - mozhttpd == 0.7 04:52:49 INFO - mozinfo == 0.9 04:52:49 INFO - mozleak == 0.1 04:52:49 INFO - mozlog == 3.4 04:52:49 INFO - moznetwork == 0.27 04:52:49 INFO - mozprocess == 0.25 04:52:49 INFO - mozprofile == 0.28 04:52:49 INFO - mozrunner == 6.13 04:52:49 INFO - mozscreenshot == 0.1 04:52:49 INFO - mozsystemmonitor == 0.3 04:52:49 INFO - moztest == 0.8 04:52:49 INFO - mozversion == 1.4 04:52:49 INFO - psutil == 3.1.1 04:52:49 INFO - requests == 1.2.3 04:52:49 INFO - wsgiref == 0.1.2 04:52:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:52:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:52:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:52:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:49 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 0x109efbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109efe768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85fbd639d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109cd9d30>, '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 0x109c00db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109ccebe8>, '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.n9e71pItTD/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.kVpnxlNZJP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/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 04:52:49 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 04:52:49 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 04:52:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.n9e71pItTD/Render', 04:52:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:52:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:52:49 INFO - 'HOME': '/Users/cltbld', 04:52:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:52:49 INFO - 'LOGNAME': 'cltbld', 04:52:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:49 INFO - 'MOZ_NO_REMOTE': '1', 04:52:49 INFO - 'NO_EM_RESTART': '1', 04:52:49 INFO - 'PAGER': '/bin/cat', 04:52:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:52:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:49 INFO - 'PWD': '/builds/slave/test', 04:52:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:52:49 INFO - 'SHELL': '/bin/bash', 04:52:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kVpnxlNZJP/Listeners', 04:52:49 INFO - 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/', 04:52:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:52:49 INFO - 'USER': 'cltbld', 04:52:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:52:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:52:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:49 INFO - 'XPC_FLAGS': '0x0', 04:52:49 INFO - 'XPC_SERVICE_NAME': '0', 04:52:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:52:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:49 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)) 04:52:49 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)) 04:52:49 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)) 04:52:49 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)) 04:52:49 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)) 04:52:49 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)) 04:52:49 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)) 04:52:49 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)) 04:52:49 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)) 04:52:49 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)) 04:52:49 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)) 04:52:49 INFO - Cleaning up... 04:52:49 INFO - Return code: 0 04:52:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:52:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:52:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:52:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109efbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109efe768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85fbd639d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109cd9d30>, '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 0x109c00db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109ccebe8>, '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.n9e71pItTD/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.kVpnxlNZJP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/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 04:52:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:52:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:52:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.n9e71pItTD/Render', 04:52:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:52:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:52:49 INFO - 'HOME': '/Users/cltbld', 04:52:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:52:49 INFO - 'LOGNAME': 'cltbld', 04:52:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:49 INFO - 'MOZ_NO_REMOTE': '1', 04:52:49 INFO - 'NO_EM_RESTART': '1', 04:52:49 INFO - 'PAGER': '/bin/cat', 04:52:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:52:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:49 INFO - 'PWD': '/builds/slave/test', 04:52:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:52:49 INFO - 'SHELL': '/bin/bash', 04:52:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kVpnxlNZJP/Listeners', 04:52:49 INFO - 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/', 04:52:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:52:49 INFO - 'USER': 'cltbld', 04:52:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:52:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:52:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:49 INFO - 'XPC_FLAGS': '0x0', 04:52:49 INFO - 'XPC_SERVICE_NAME': '0', 04:52:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:52:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:52:50 INFO - Cleaning up... 04:52:50 INFO - Return code: 0 04:52:50 INFO - Running post-action listener: _resource_record_post_action 04:52:50 INFO - Running post-action listener: _start_resource_monitoring 04:52:50 INFO - Starting resource monitoring. 04:52:50 INFO - [mozharness: 2017-04-04 11:52:50.121977Z] Finished create-virtualenv step (success) 04:52:50 INFO - [mozharness: 2017-04-04 11:52:50.122934Z] Running install step. 04:52:50 INFO - Running pre-action listener: _resource_record_pre_action 04:52:50 INFO - Running main action method: install 04:52:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:52:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:52:50 INFO - Reading from file tmpfile_stdout 04:52:50 INFO - Detecting whether we're running mozinstall >=1.0... 04:52:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:52:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:52:50 INFO - Reading from file tmpfile_stdout 04:52:50 INFO - Output received: 04:52:50 INFO - Usage: mozinstall [options] installer 04:52:50 INFO - Options: 04:52:50 INFO - -h, --help show this help message and exit 04:52:50 INFO - -d DEST, --destination=DEST 04:52:50 INFO - Directory to install application into. [default: 04:52:50 INFO - "/builds/slave/test"] 04:52:50 INFO - --app=APP Application being installed. [default: firefox] 04:52:50 INFO - mkdir: /builds/slave/test/build/application 04:52:50 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'] 04:52:50 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 04:53:10 INFO - Reading from file tmpfile_stdout 04:53:10 INFO - Output received: 04:53:10 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 04:53:10 INFO - Running post-action listener: _resource_record_post_action 04:53:10 INFO - [mozharness: 2017-04-04 11:53:10.789766Z] Finished install step (success) 04:53:10 INFO - [mozharness: 2017-04-04 11:53:10.789916Z] Running run-tests step. 04:53:10 INFO - Running pre-action listener: _resource_record_pre_action 04:53:10 INFO - Running main action method: run_tests 04:53:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:53:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:53:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:53:10 INFO - 2017-04-04 04:53:10.804 screenresolution[1626:7552] starting screenresolution argv=screenresolution get 04:53:10 INFO - 2017-04-04 04:53:10.807 screenresolution[1626:7552] Display 0: 1600x1200x32@60 04:53:10 INFO - 2017-04-04 04:53:10.812 screenresolution[1627:7555] starting screenresolution argv=screenresolution list 04:53:10 INFO - Available Modes on Display 0 04:53:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:53:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:53:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:53:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:53:11 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:53:11 INFO - Intel Iris: 04:53:11 INFO - Chipset Model: Intel Iris 04:53:11 INFO - Type: GPU 04:53:11 INFO - Bus: Built-In 04:53:11 INFO - VRAM (Dynamic, Max): 1536 MB 04:53:11 INFO - Vendor: Intel (0x8086) 04:53:11 INFO - Device ID: 0x0a2e 04:53:11 INFO - Revision ID: 0x0009 04:53:11 INFO - Displays: 04:53:11 INFO - Display: 04:53:11 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:53:11 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:53:11 INFO - Display Serial Number: 1600x1200 60 04:53:11 INFO - Main Display: Yes 04:53:11 INFO - Mirror: Off 04:53:11 INFO - Online: Yes 04:53:11 INFO - Rotation: Supported 04:53:11 INFO - Return code: 0 04:53:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:53:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:53:11 INFO - Python 2.7.3 04:53:11 INFO - Return code: 0 04:53:11 INFO - grabbing minidump binary from tooltool 04:53:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:11 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 0x109cd9d30>, '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 0x109c00db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109ccebe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:53:11 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 04:53:11 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 04:53:11 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 04:53:11 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:53:11 INFO - Return code: 0 04:53:11 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:53:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:53:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:53:11 INFO - ENV: RUST_BACKTRACE is now 1 04:53:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:53:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:53:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DD5TEWs3QH215aOaprSWcQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0305', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:53:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DD5TEWs3QH215aOaprSWcQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0305 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:53:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.n9e71pItTD/Render', 04:53:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:53:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:53:11 INFO - 'HOME': '/Users/cltbld', 04:53:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:53:11 INFO - 'LOGNAME': 'cltbld', 04:53:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:53:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:53:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:11 INFO - 'MOZ_NO_REMOTE': '1', 04:53:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:53:11 INFO - 'NO_EM_RESTART': '1', 04:53:11 INFO - 'PAGER': '/bin/cat', 04:53:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:53:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:11 INFO - 'PWD': '/builds/slave/test', 04:53:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:53:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:53:11 INFO - 'RUST_BACKTRACE': '1', 04:53:11 INFO - 'SHELL': '/bin/bash', 04:53:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kVpnxlNZJP/Listeners', 04:53:11 INFO - 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/', 04:53:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:53:11 INFO - 'USER': 'cltbld', 04:53:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:53:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:53:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:11 INFO - 'XPC_FLAGS': '0x0', 04:53:11 INFO - 'XPC_SERVICE_NAME': '0', 04:53:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:53:11 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DD5TEWs3QH215aOaprSWcQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0305', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:53:11 INFO - mozversion application_buildid: 20170404033427 04:53:11 INFO - mozversion application_changeset: 916a4ee676a33355fc717f15ecb80815ba95051e 04:53:11 INFO - mozversion application_display_name: Nightly 04:53:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:53:11 INFO - mozversion application_name: Firefox 04:53:11 INFO - mozversion application_remotingname: firefox 04:53:11 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:53:11 INFO - mozversion application_vendor: Mozilla 04:53:11 INFO - mozversion application_version: 55.0a1 04:53:11 INFO - mozversion platform_buildid: 20170404033427 04:53:11 INFO - mozversion platform_changeset: 916a4ee676a33355fc717f15ecb80815ba95051e 04:53:11 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:53:11 INFO - mozversion platform_version: 55.0a1 04:53:11 INFO - using testdate: 1491306791 04:53:11 INFO - actual date: 1491306791 04:53:11 INFO - starting webserver on 'localhost:49241' 04:53:11 INFO - SUITE-START | Running 2 tests 04:53:11 INFO - TEST-START | dromaeo_css 04:53:11 INFO - operating with platform_type : mac_ 04:53:11 INFO - Initialising browser for dromaeo_css test... 04:53:11 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/tmpLo2HSu/profile http://localhost:49241/getInfo.html) 04:53:13 INFO - PID 1637 | __metrics Screen width/height:1600/1200 04:53:13 INFO - PID 1637 | colorDepth:24 04:53:13 INFO - PID 1637 | Browser inner width/height: 1024/689 04:53:13 INFO - PID 1637 | __metrics 04:53:14 INFO - PID 1637 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:53:14 INFO - PID 1637 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:53:14 INFO - TEST-INFO | 1637: exit 0 04:53:14 INFO - Browser initialized. 04:53:14 INFO - Running cycle 1/1 for dromaeo_css test... 04:53:14 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/tmpLo2HSu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:53:26 INFO - PID 1639 | RSS: Main: 233775104 04:53:26 INFO - PID 1639 | 04:56:32 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 04:56:33 INFO - PID 1639 | RSS: Main: 383512576 04:56:33 INFO - PID 1639 | 04:58:16 INFO - PID 1639 | ************************* 04:58:16 INFO - PID 1639 | A coding exception was thrown and uncaught in a Task. 04:58:16 INFO - PID 1639 | 04:58:16 ERROR - PID 1639 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:58:16 INFO - PID 1639 | Full stack: 04:58:16 INFO - PID 1639 | ************************* 04:58:16 INFO - PID 1639 | ************************* 04:58:16 INFO - PID 1639 | A coding exception was thrown and uncaught in a Task. 04:58:16 INFO - PID 1639 | 04:58:16 ERROR - PID 1639 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:58:16 INFO - PID 1639 | Full stack: 04:58:16 INFO - PID 1639 | ************************* 04:58:16 INFO - PID 1639 | ************************* 04:58:16 INFO - PID 1639 | A coding exception was thrown and uncaught in a Task. 04:58:16 INFO - PID 1639 | 04:58:16 ERROR - PID 1639 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:58:16 INFO - PID 1639 | Full stack: 04:58:16 INFO - PID 1639 | ************************* 04:58:16 INFO - PID 1639 | ************************* 04:58:16 INFO - PID 1639 | A coding exception was thrown and uncaught in a Task. 04:58:16 INFO - PID 1639 | 04:58:16 ERROR - PID 1639 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:58:16 INFO - PID 1639 | Full stack: 04:58:16 INFO - PID 1639 | ************************* 04:59:36 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 04:59:37 INFO - PID 1639 | RSS: Main: 372273152 04:59:37 INFO - PID 1639 | 05:02:39 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 05:02:40 INFO - PID 1639 | RSS: Main: 358019072 05:02:40 INFO - PID 1639 | 05:05:42 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 05:05:43 INFO - PID 1639 | RSS: Main: 359661568 05:05:43 INFO - PID 1639 | 05:08:46 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 05:08:47 INFO - PID 1639 | RSS: Main: 334053376 05:08:47 INFO - PID 1639 | 05:11:50 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 05:11:51 INFO - PID 1639 | RSS: Main: 485363712 05:11:51 INFO - PID 1639 | 05:11:51 INFO - PID 1639 | __start_tp_report 05:11:51 INFO - PID 1639 | _x_x_mozilla_page_load 05:11:51 INFO - PID 1639 | _x_x_mozilla_page_load_details 05:11:51 INFO - PID 1639 | |i|pagename|runs| 05:11:51 INFO - PID 1639 | |0;dojo.html;3480.982595087024;3485.0938755923453;3489.4591338342566;3520.630333814949;3568.357695614788;6002.219711437507;6099.612447337997;6191.226096737908;6208.379162083789;6220.346863579327;5026.9497305026935;6089.269287685473;6141.1095391168255;6177.135201071854;6181.690915454221;4768.47546769855;5196;5245.9213111803165;5326.467353264681;5444.700541470217;5419.241306217133;5422.078246698071;5426.593005524602;5430.83707488776;5459.617826752129;5194.506521880416;5290.312259406252;5301.549368303698;5317.468253174651;5366.758495867676;5310;5328.573714102862;5386.245925570423;5403.324584426947;5410.431904649994;5313.149896016619;5323.627346085776;5330.626856120073;5336.4129945705945;5392.379876314235;5988.490978266853;6019.729112189962;6169.84575385619;6173.197484327009;6187.783427580058;6347.904781428282;6503.902441463382;6584.440322572587;6599.142111525519;6601.7359305627715;5570.526505247059;6727.66361681914;6731.932680673229;6745.831354216135;6750.426213771835;6207.503399728011;6342.9851223804435;6344.016677414962;6359.872802543923;6364.395382438661;6454.870902581922;6550.115734375799;6778.93221067783;6831.795046148623;6867.107276054081;6254.437100660872;6313.968430157912;6329.082283069021;6497.837554061091;6541.313162117909;5585.720713964285;5618.887622247532;6569.934300657028;6695.062691223233;6716.3955244028275;6540.9345906541275;6542.771003014872;6559.8032059038305;6602.141721576164;6664.766733164316;6251.99968005117;6287.654179020198;6294.370562943669;6496.317886621931;6558.704858281389;5274.208868669653;5285.471452854761;5291.074062039128;5293.708846013429;5310.946890531122;4667.603253723403;4680.438347398334;4704.788284527204;4755.667103302805;4766.666333356632;6198.969005154945;6217.751289948442;6261.467775239064;6271.43557079865;6274.780382686584;6326.715297811609;6405.263394709575;6428.77499287532;6600.141981542369;6716.29478904708;6284.811455656246;6302.810915672537;6304.464120549713;6304.716287767062;6313.305536391085;5744.454276843693;5780.1907732917425;5809;5823.838847198972;5868.207791948118;6504.4796416285635;6564.868702626016;6591.439727623014;6854;6879.724811007503;5746.224259724883;6004;6351.587146835441;6647;6676.532642714963;6646.468282537482;6820.863582728417;6840.623765692934;6847.21257055425;6864.553804002724;6241.407066328691;6439.581427207217;6537.248216455168;6554.770583029571;6574.0796288520605;6427.614343139427;6579.309172536815;6603.372679595431;6673.9332606673315;6694.330566943461;6430.710618022294;6446.194225721785;6457.4511166551365;6489.4808415325715;6503.2846386898345;5612.747426365741;6233;6241.875162496815;6308;6345.619262844244;6281.12064311006;6295.433410993032;6298;6307.05394190875;6308.148399965946;6225.719842607185;6300.9684951574945;6319.936800631935;6364.4908407326375;6367.872642547216;6215.875682486235;6270.49836013127;6295.527835412271;6301.275353334425;6308.211473565804 05:11:51 INFO - PID 1639 | |1;ext.html;749.5914726474072;795.7214974758836;813.0974618173826;1009.439760932682;1116.5924437580281;27836;28287.717122828766;36984;37456.81271593645;37537.812310938476;39629.801850990705;39757.60242397575;39799.602003979955;39896;39919.800400997956;8527.445716028438;8717.041125476224;8744.30045596354;8754.781130471725;8761.16768906956;6134.4478996890275;6302.401271879165;7438.404927605806;8441.620127094295;8731.388802783807;8550.059493455716;8678.262347700453;8679.869801952977;8686.131386861327;8689.391742578022;8577.142285771435;8649.351298652626;8658.177473140042;8669.08974557675;8671.826563468758;8505.957470212672;8567.742967710916;8573.52845593492;8576.914230857674;8591.527465989368;37450.62549374526;37458;37647;37742;37960;2982.9552556711665;3027.3700595695577;3041.58938543296;3057.159281197666;3066.294752207005;27847.72152278492;28251.85874070637;28452.430951380855;28464.857675711697;29447.852760736274;2831.490331740286;2832.2636114610145;2855.957160642571;2867.440849034439;2898.4637841999297;353252.4674753245;353798;355745;356063;358497;51583.226251605505;51949.740251299256;51983;52001.69995750137;52003;54369.1844622331;54556.90886182254;54584.90830183374;54685;54763.45236547663;12780.424880880382;12960.611181664564;12962.80555791664;12985.675358116123;12997.805032924514;10239;10243.180545556337;10257.17942564593;10270.435126067989;10306.690799276033;11753.941230293965;12002.759944801055;12007.979321757748;12011;12018.33899135556;5673.914891276634;5907.734151963172;5943.435373639497;5964.910526342108;5968.612040217372;958.6117622362954;985.5170966226498;992.5136683025265;1041.9010194031555;1045.749020235138;22998.8850055752;24178.87910560436;24182;24214.87892560526;24286.90708918103;1075.58589942871;1076.9353838769541;1125.358545629;1128.2553514680435;1139.2708666453477;11467.139964502529;12058.216215945935;12259.57091501811;12417.813732794015;12436;482751;485628;486698;488445.80879338103;489811.7547061352;53011.73494132505;53385.46614533805;53460.93078138493;53512.46487535075;53527.46472535303;1311.2591385867336;1411.7600007998665;1493.3429291111877;1505.0593379138038;1510.3731951240331;22871;23432.88283558571;23468.76531234734;23531.294061178192;23559.646605301277;36962.26075478529;37058.8147059263;37087;37108.88673339804;37139.28607139264;418328;418388.90805545775;419329;421496;421633;33308.000759977236;33620;34190.65809341974;34327.65672343344;34350.65649343475;42227.788861055495;42572;42916;42935.57064429441;43066;27982.72017279801;28196.577051344655;29697.554536681535;30035;30339.87620866518;23782.207871680374;26500.73499264983;27096.72903270942;29598.260043499085;29955.70044299529;35258.47112293369;35364.29271414609;35419.82290088533;36340;36484.45273320955;28993.85503072471;29461;29999.850000749855;30214.54678179873;30647.007944483536;20549.075291611614;22865.50723199405;23273.53452930898;23633.763662363155;24187.395315117265 05:11:51 INFO - PID 1639 | |2;jquery.html;378.4247943126446;392.74275349645956;414.77602094868774;426.27745970579866;426.5031238607022;13381.665458363546;15481.303341349638;21120.0495977681;22000.44998875029;22141.44646383839;21615.1353945842;21808.563828723418;21814.018369173424;22161.33515994523;22176.667349989762;5919.082542205965;5945.405459454052;6090.147379366892;6164.907526387108;6172.84567885802;3631.909202269938;3808.9619103809023;6002.309734380558;6129.938700613004;6142.508599312045;3821;4480.798364073608;5253.763580638862;6106.572539922207;6112.419320164599;6036.456718895277;6104.08438734189;6107.4808641265545;6115.266168059861;6115.663638499903;5197;5422.2951016368015;5422.376426710939;5426.891462170774;5427.728613569306;25763.613545796827;26370.472590548274;26457.47085058307;26542.07102751414;26759.73240267592;2048.6107639548586;2054.866433681806;2064.1743302678897;2099.8320134389214;2154.3859999899955;15739.213039347987;15999.440019599258;16108.919455402765;16209.270582823683;16781.748273775902;1803.5491127218195;1847.7136043913215;1884.3969929622526;1891.9432417027374;1903.1055403960117;138331;143063;144327;145465;147148;9677.467739274407;11711.824322635168;11833.526658933546;11840.940795295968;11877.762444751057;15617.297221625055;15623.375064997274;15681.68636627261;15684.76472852908;15738.9213053934;7143.42852571793;7808.609569521501;7849.372050235967;8106.554139522383;8203.466774659628;6226.439620434183;7464;7644.770656880302;7652.464327497133;7657.310842024244;7177.7487787927175;7312.415006799443;7335.486515943832;7351.22812104732;7352.301531354513;2050.6513892638286;2068.813806757399;2069.172331067585;2073.859377342486;2074.686724302392;901.2024358442825;931.2456909903;944.1313991128178;961.3174646001418;977.4917043137671;16579.67362610988;19514.804851951583;20252.898735506522;20325.18699252043;20457.693134602992;951.3720944176948;956.8565564150773;975.3367709957297;989.0653332600767;992.1021475564481;10294;10382.688519344432;10429.530671119817;10494.898035706294;10531.89468105309;675174;679832;691412;723935;727713;112353.75292494104;138714;142507.287463562;149377;153287;1144.7767685301287;1174.7767924094394;1196.222455403977;1199.8560172779148;1200.8318835363057;18505.72241416407;18941.242350305834;19655.606887861875;19714.60570788605;20789.376318710463;60957.695211523656;61408.69295653672;61636;62159;62682;65046;86488.70266945875;89451;92812.53593731989;93980;8441.451305665112;8546.615402306787;8703.95648021756;8772.605232764668;8775.868361974448;13518.05373623837;13699.520516781864;13731.519396821062;14109.082909610843;14150.150990940576;11543.88456115428;11689.5149103988;11809.173357864867;11878;11966.282023078644;9671.613135474783;11004.449777511252;11027.503762330554;11191.832122518332;11394.658160255205;11606.825897611374;11646.767064658829;12004.039676825658;12159.696007599881;12165;8434.24091831738;8609.450298946249;8614.65541378338;8690.566056600843;8986;11570.132240081859;11622.244554103956;11890.405479726152;12024.819627705767;12085.335306558223 05:11:51 INFO - PID 1639 | |3;mootools.html;1359.918404895706;1423.3452611798573;1446.7540518111916;1451.2671101093947;1451.8983671143023;10395.584176632925;10837.729056773585;10856.78286434271;10860.34837909726;10878.564857405694;10467.214958878076;10592.152627789777;10741.785164296709;10843.6746897593;10847.51186196621;2411.3850968003135;2478.095495144268;2478.6653801736807;2486.78862296705;2488.8382255153356;2419.2621250518587;2430;2481.5161043596504;2483.8261321707487;2483.913063042794;2361.2916125162383;2462.5813611685967;2466.235467005234;2469.197510808994;2471.7630544357294;2424.3090719144957;2433.245693834917;2443.462438263588;2472.4189815393456;2474.418511649761;2421.176799888029;2424.090965887792;2433.6227884677905;2438.3416477550963;2439.1950656283384;8672.956635216846;10896.182786290981;10912;10912.23614346996;10922.29005114665;6182.165407669952;6422.518311126684;6433.131527243809;6434.742610295582;6445.162128923257;3592.5750118669794;3701.870434534805;3796.8101594920145;4008.7995600219874;4021.577734337882;1187.928724276546;1526.5344070058627;1565.3503795924678;1594.9681006379924;1640.9425670101489;14884.181370024644;15059.623509412242;15217;15220.695586088215;15245.237738112939;4968.503149685075;5474.151506516497;5624.156376543551;5655.293088363955;5767.913481297784;12643.051771117203;12662.113652044269;12663;12691.49234030647;12698.492060317669;6396.328385519547;6404.071409645669;6408.551401401857;6418.550701450947;6423.710933007932;5672.546196304285;5806.303243610793;5863.120531920161;5904.7933322334375;5920.141579470953;4220.894477638022;4362.781860906942;4383.912321753547;4413.558644135561;4455.287154055401;1339.5177736015028;1393.4635165461168;1402.4670625162373;1409.2108419285232;1414.6702100025943;742.2317900972467;748.8988986486754;777.7161336112391;784.9175836537196;805.3235282362726;5841.532677385799;5863.794767183128;5979.730912108966;6030.7286172121485;6036.245469316335;565.2453973944747;589.9085641725453;596.9582129250911;602.5781952633174;604.9866473656607;3469.254110366233;4029.657479114308;4082.775447350424;4117.958820411817;4201.747895126302;13132.409041593151;13790.310484475736;13809.585712428643;13830.962677799205;13833.723325533432;12118.515259389702;12562.246265224116;13699.794503082461;13700.725985480234;13713.520026799015;8659;9770.267229957639;9934.105930466438;9980.451075190935;10172.440515771703;5105.7702403391195;6585.5719378240265;6666.500012498985;6795.592264464148;6812.318768123347;11776.234544754563;12235.69410764738;12247.938760306142;12276;12401.00791936661;11162.944185279022;11445.912638299349;12272.570460033856;12513.436895339913;12546.811797823222;7949.920500794918;8264.669413223644;8759.343049271203;9142.817143657223;9189.218916392181;7778.37772978149;9974.301798874008;10311.896881031094;10312.48437578103;10338.741531461774;7341;8319.792005199919;8597.699080532151;8624.533829248918;8639.481631102153;8356.916430835858;8370.246677799027;8415.242628163494;8463.942007249094;8547.52988585609;7705.807354816175;7752.341051010727;7817.140114587277;7819.296263336099;7835.764927052198;5701.800436984686;5781.103928891029;5857.824265272048;5913.733881975236;5971.0744834550715;5779.826605201851;5805.796797112081;5918;6020.849478763066;6173.135760993554 05:11:51 INFO - PID 1639 | |4;prototype.html;353.98584056637736;366.9101070237792;379.68865530265174;390.1708868654108;401.3357892687602;6038.580933480628;6117.602355846872;6120.632762034275;6154.107654390111;6173.413525715061;5772.5670574706955;5865.149553314767;5876.588638795286;5940.594059405937;5963.731632076556;3947.4868267125235;4024.678025757947;4372.737635741865;4415.757133357664;4425.734455932638;4280.807363668627;4410.75740834254;4437.557793717038;4450.265706158496;4461.39771130898;4306.547812479692;4339.566043395651;4356.411884395614;4371.907023244189;4380.934285985712;4355.542668019844;4362.411074504965;4368.322909948963;4384.605385515319;4386.320120381346;3763.6048214937587;3798.791066491342;3814.7901865397394;3816.313063648542;3821.1211421372964;4799.552228363525;5603.719814009324;5850.18644220293;5904.852378690524;5921.792737254218;5220.817271395483;5226.764795584208;5251.658642188284;5263.710495922723;5267.789288428458;6084.421979911901;6384.93615063848;6395.552311338208;6426.646534440604;6465.935340646627;3763.473113764075;3779.640934111255;4164.5210800757695;4264.040590867061;4270.103278311558;5428.5114339708825;5508.476694713996;6386.168299020597;6571.507136964747;6742.932570674279;3845.4808600839087;4240.91518169641;4345.891352716208;4370.300751879684;4395.7582332972;3898.2983063048355;4134;4429.136318417877;4451.3323001550025;4452.510223875371;4717.882052948635;5030.974845125751;5141.151709967813;5187.118189907725;5196;5254.474552544715;5276.150878525553;5881.647101173943;6330.398612131932;6376.39424254695;1432.5702289313165;1482.606350030989;1496.5435542159528;1501.159350763576;1508.954731358061;830;918.9724308270762;977.7702239973601;998.3810037776625;1000.8690180096445;5053.9241911371355;5537.314402514777;5979.431953964367;5982.316799040842;5993.910091348634;6631.115464772839;6633.502487313471;6639.468842492589;6655.367740064686;6699.794037073276;4712.481627021025;5854.347026607978;5872;5967.880642387128;5976.834517269091;3027.819150531295;3310.553075334847;3416.3338149060696;3440.9655903441144;3457.896263112111;5264.684118952875;5441.510264076173;6208.771438851772;6652.135222421151;6744.62904540255;5595.636283641632;6701.29636388182;6732.932670673231;6746.446148849605;6748.29142939994;6423.164988551458;6728.259891411941;6748.223954245324;6748.696308666122;6753.885608874579;5511.476409741229;6607.867842643024;6623.271440141677;6676.232233293234;6687;6547.836304092436;6574.046763219402;6574.342565743387;6595.571287866273;6617.636030018202;5395.919061214164;6417.711202995783;6499.252585952676;6815.931840681728;6820.556663816836;3992.784004877321;4672.906541869075;4844.128056949783;4846.636502262274;4852.878678033077;6442.710078046593;6591.637459939558;6672.899906501503;6724.125863637696;6732.3267673232285;6434.06706027614;6441.516886233645;6443.613383197023;6464.709088090953;6466.351080474449;5356.491133342326;6061.545384096122;6404.9039264412;6431.48548116159;6459.515536334699;5206.843794686166;6147.754089836357;6207.193064901534;6277.654728989767;6297.937020629735;5345.278387417804;5936.554758393224;6426.485881129405;6441.806745797634;6457.547971642128;5517.841253336845;5959.970200148971;6237.064440333805;6250.3749625037135;6260.248770147429 05:11:51 INFO - PID 1639 | |5;yui.html;718.633496916573;719.208870242733;738.3834498194009;745.4446437404134;768.8692922203228;15429.537113886587;15680.215989200522;16513.917430412832;16569.50291491256;16577.75133372999;14659.12045277284;15130.54608361748;15157.696846063072;15282.00666956647;15326.080435173897;976.5166242709851;1003.2926786615419;1006.0191313469383;1007.2999265510473;1011.6206422591529;983.5967253426097;992.0030369478663;997.725625452999;997.930144889858;1000.6647772996055;1006.954687039085;1064.084886997182;1067.674359320407;1069.6684027951321;1070.0262760887595;1053.5048527192207;1056.2553399853161;1056.9682909512726;1057.7937302226069;1064.435849000031;788.2393490281848;790.3953475591177;790.6363072986433;791.5211297165247;795.7016118955391;16780.748288775678;17172.39896603613;17233.741493877602;17319.047452390114;17433.912830435893;12657;12791.026627292318;13246.735065298737;14806.555803325917;15017.849821501755;11249.325040497515;11481.655550333504;11698.181127321091;11703.122265830012;12052.45763940616;3065.7853950223493;3075.169704179881;3093.876244950199;3127.37452509499;3193.2495863472063;84158.47524574272;107904;109207;110542.89457105487;111477.44261278723;11577.6526704199;11716.297022178696;11726.296422214524;11734.823977640342;12046.698832529082;25128.24615261545;25217.243482695547;25397.492050158893;25448.49103017929;25486.107986220763;8161.347092232607;8240.175982401712;8292.295154911779;8307.750767476986;8311.750647480585;4105.651019663303;4110.979445102756;4202.306619407825;4250.851220207278;4252.192083504125;4058.3912413138264;4190.245755763992;4220.5146408163455;4225.154969006211;4229.2598795210715;824.6083110522574;825.9050209225895;837;838.9706360277361;853.4367317570374;527.7730575852344;554.4289381936612;573.9368669446358;576.700115939709;578.7540295374449;9714.708558743248;10293.94853025745;10376.948115259376;10430.687079387479;10542.52558634848;538.1922895514252;586.5102639296235;587.5802827543655;593.1251404178802;594.1622312539299;3587.0852932502044;3690.8523659053335;4310.870673879788;4677.298405239241;4701.294805779092;96568.06626906482;98437.50781246192;99345.50327248317;101098.494507527;101152;89207.55396223108;89531.55234223788;90477.54761226283;91091;91194;71702;71813;72908.27091729015;73571.26428735751;74073.62963185257;9349.06722618202;9354.766130846783;9361.204297634506;9405.99988024201;9416.717498475056;39130.82607521779;39185.608143918194;39555.2088958225;39778.80110599429;40166.799166003984;33006;41489.37765933574;51371.22943155781;51455;52053;11574.71063223426;11650.126240532163;11903.821442678194;11987.460564274803;12547.247165169754;12956.740865182832;12970.675733106747;13043.673908152372;13136.138342325696;13168.60494185176;11679.766404671689;11813.822792657946;11849.703757406134;11885.940570297093;12238.265704057429;11877;12131.696707582028;12227.205231659913;12269.263844169378;12465.189762665397;11580.189386742848;11619.244749091282;12086.335251561248;12266.448009839758;12362.196457230251;8565.614547345509;8634.349003004383;8797.648094076165;8817.603207855534;9266.814663706822;6770.052192692929;8462.280706140047;9642.132208101304;9782.60326719364;10107.79784404293 05:11:51 INFO - PID 1639 | __end_tp_report 05:11:51 INFO - PID 1639 | __start_cc_report 05:11:51 INFO - PID 1639 | _x_x_mozilla_cycle_collect,1599 05:11:51 INFO - PID 1639 | __end_cc_report 05:11:51 INFO - PID 1639 | __startTimestamp1491307911118__endTimestamp 05:11:51 INFO - PID 1639 | 05:11:51 INFO - PID 1639 | ------- Summary: start ------- 05:11:51 INFO - PID 1639 | Number of tests: 6 05:11:51 INFO - PID 1639 | 05:11:51 INFO - PID 1639 | [#0] dojo.html Cycles:165 Average:6034.64 Median:6287.65 stddev:704.96 (11.2%) stddev-sans-first:678.06 05:11:51 INFO - PID 1639 | Values: 3481.0 3485.1 3489.5 3520.6 3568.4 6002.2 6099.6 6191.2 6208.4 6220.3 5026.9 6089.3 6141.1 6177.1 6181.7 4768.5 5196.0 5245.9 5326.5 5444.7 5419.2 5422.1 5426.6 5430.8 5459.6 5194.5 5290.3 5301.5 5317.5 5366.8 5310.0 5328.6 5386.2 5403.3 5410.4 5313.1 5323.6 5330.6 5336.4 5392.4 5988.5 6019.7 6169.8 6173.2 6187.8 6347.9 6503.9 6584.4 6599.1 6601.7 5570.5 6727.7 6731.9 6745.8 6750.4 6207.5 6343.0 6344.0 6359.9 6364.4 6454.9 6550.1 6778.9 6831.8 6867.1 6254.4 6314.0 6329.1 6497.8 6541.3 5585.7 5618.9 6569.9 6695.1 6716.4 6540.9 6542.8 6559.8 6602.1 6664.8 6252.0 6287.7 6294.4 6496.3 6558.7 5274.2 5285.5 5291.1 5293.7 5310.9 4667.6 4680.4 4704.8 4755.7 4766.7 6199.0 6217.8 6261.5 6271.4 6274.8 6326.7 6405.3 6428.8 6600.1 6716.3 6284.8 6302.8 6304.5 6304.7 6313.3 5744.5 5780.2 5809.0 5823.8 5868.2 6504.5 6564.9 6591.4 6854.0 6879.7 5746.2 6004.0 6351.6 6647.0 6676.5 6646.5 6820.9 6840.6 6847.2 6864.6 6241.4 6439.6 6537.2 6554.8 6574.1 6427.6 6579.3 6603.4 6673.9 6694.3 6430.7 6446.2 6457.5 6489.5 6503.3 5612.7 6233.0 6241.9 6308.0 6345.6 6281.1 6295.4 6298.0 6307.1 6308.1 6225.7 6301.0 6319.9 6364.5 6367.9 6215.9 6270.5 6295.5 6301.3 6308.2 05:11:51 INFO - PID 1639 | 05:11:51 INFO - PID 1639 | [#1] ext.html Cycles:180 Average:54811.47 Median:195582.41 stddev:112807.26 (57.7%) stddev-sans-first:113050.69 05:11:51 INFO - PID 1639 | Values: 749.6 795.7 813.1 1009.4 1116.6 27836.0 28287.7 36984.0 37456.8 37537.8 39629.8 39757.6 39799.6 39896.0 39919.8 8527.4 8717.0 8744.3 8754.8 8761.2 6134.4 6302.4 7438.4 8441.6 8731.4 8550.1 8678.3 8679.9 8686.1 8689.4 8577.1 8649.4 8658.2 8669.1 8671.8 8506.0 8567.7 8573.5 8576.9 8591.5 37450.6 37458.0 37647.0 37742.0 37960.0 2983.0 3027.4 3041.6 3057.2 3066.3 27847.7 28251.9 28452.4 28464.9 29447.9 2831.5 2832.3 2856.0 2867.4 2898.5 353252.5 353798.0 355745.0 356063.0 358497.0 51583.2 51949.7 51983.0 52001.7 52003.0 54369.2 54556.9 54584.9 54685.0 54763.5 12780.4 12960.6 12962.8 12985.7 12997.8 10239.0 10243.2 10257.2 10270.4 10306.7 11753.9 12002.8 12008.0 12011.0 12018.3 5673.9 5907.7 5943.4 5964.9 5968.6 958.6 985.5 992.5 1041.9 1045.7 22998.9 24178.9 24182.0 24214.9 24286.9 1075.6 1076.9 1125.4 1128.3 1139.3 11467.1 12058.2 12259.6 12417.8 12436.0 482751.0 485628.0 486698.0 488445.8 489811.8 53011.7 53385.5 53460.9 53512.5 53527.5 1311.3 1411.8 1493.3 1505.1 1510.4 22871.0 23432.9 23468.8 23531.3 23559.6 36962.3 37058.8 37087.0 37108.9 37139.3 418328.0 418388.9 419329.0 421496.0 421633.0 33308.0 33620.0 34190.7 34327.7 34350.7 42227.8 42572.0 42916.0 42935.6 43066.0 27982.7 28196.6 29697.6 30035.0 30339.9 23782.2 26500.7 27096.7 29598.3 29955.7 35258.5 35364.3 35419.8 36340.0 36484.5 28993.9 29461.0 29999.9 30214.5 30647.0 20549.1 22865.5 23273.5 23633.8 24187.4 05:11:51 INFO - PID 1639 | 05:11:51 INFO - PID 1639 | [#2] jquery.html Cycles:180 Average:39636.97 Median:22151.39 stddev:116891.15 (527.7%) stddev-sans-first:117181.89 05:11:51 INFO - PID 1639 | Values: 378.4 392.7 414.8 426.3 426.5 13381.7 15481.3 21120.0 22000.4 22141.4 21615.1 21808.6 21814.0 22161.3 22176.7 5919.1 5945.4 6090.1 6164.9 6172.8 3631.9 3809.0 6002.3 6129.9 6142.5 3821.0 4480.8 5253.8 6106.6 6112.4 6036.5 6104.1 6107.5 6115.3 6115.7 5197.0 5422.3 5422.4 5426.9 5427.7 25763.6 26370.5 26457.5 26542.1 26759.7 2048.6 2054.9 2064.2 2099.8 2154.4 15739.2 15999.4 16108.9 16209.3 16781.7 1803.5 1847.7 1884.4 1891.9 1903.1 138331.0 143063.0 144327.0 145465.0 147148.0 9677.5 11711.8 11833.5 11840.9 11877.8 15617.3 15623.4 15681.7 15684.8 15738.9 7143.4 7808.6 7849.4 8106.6 8203.5 6226.4 7464.0 7644.8 7652.5 7657.3 7177.7 7312.4 7335.5 7351.2 7352.3 2050.7 2068.8 2069.2 2073.9 2074.7 901.2 931.2 944.1 961.3 977.5 16579.7 19514.8 20252.9 20325.2 20457.7 951.4 956.9 975.3 989.1 992.1 10294.0 10382.7 10429.5 10494.9 10531.9 675174.0 679832.0 691412.0 723935.0 727713.0 112353.8 138714.0 142507.3 149377.0 153287.0 1144.8 1174.8 1196.2 1199.9 1200.8 18505.7 18941.2 19655.6 19714.6 20789.4 60957.7 61408.7 61636.0 62159.0 62682.0 65046.0 86488.7 89451.0 92812.5 93980.0 8441.5 8546.6 8704.0 8772.6 8775.9 13518.1 13699.5 13731.5 14109.1 14150.2 11543.9 11689.5 11809.2 11878.0 11966.3 9671.6 11004.4 11027.5 11191.8 11394.7 11606.8 11646.8 12004.0 12159.7 12165.0 8434.2 8609.5 8614.7 8690.6 8986.0 11570.1 11622.2 11890.4 12024.8 12085.3 05:11:51 INFO - PID 1639 | 05:11:51 INFO - PID 1639 | [#3] mootools.html Cycles:180 Average:6714.82 Median:3749.34 stddev:4114.67 (109.7%) stddev-sans-first:4106.54 05:11:51 INFO - PID 1639 | Values: 1359.9 1423.3 1446.8 1451.3 1451.9 10395.6 10837.7 10856.8 10860.3 10878.6 10467.2 10592.2 10741.8 10843.7 10847.5 2411.4 2478.1 2478.7 2486.8 2488.8 2419.3 2430.0 2481.5 2483.8 2483.9 2361.3 2462.6 2466.2 2469.2 2471.8 2424.3 2433.2 2443.5 2472.4 2474.4 2421.2 2424.1 2433.6 2438.3 2439.2 8673.0 10896.2 10912.0 10912.2 10922.3 6182.2 6422.5 6433.1 6434.7 6445.2 3592.6 3701.9 3796.8 4008.8 4021.6 1187.9 1526.5 1565.4 1595.0 1640.9 14884.2 15059.6 15217.0 15220.7 15245.2 4968.5 5474.2 5624.2 5655.3 5767.9 12643.1 12662.1 12663.0 12691.5 12698.5 6396.3 6404.1 6408.6 6418.6 6423.7 5672.5 5806.3 5863.1 5904.8 5920.1 4220.9 4362.8 4383.9 4413.6 4455.3 1339.5 1393.5 1402.5 1409.2 1414.7 742.2 748.9 777.7 784.9 805.3 5841.5 5863.8 5979.7 6030.7 6036.2 565.2 589.9 597.0 602.6 605.0 3469.3 4029.7 4082.8 4118.0 4201.7 13132.4 13790.3 13809.6 13831.0 13833.7 12118.5 12562.2 13699.8 13700.7 13713.5 8659.0 9770.3 9934.1 9980.5 10172.4 5105.8 6585.6 6666.5 6795.6 6812.3 11776.2 12235.7 12247.9 12276.0 12401.0 11162.9 11445.9 12272.6 12513.4 12546.8 7949.9 8264.7 8759.3 9142.8 9189.2 7778.4 9974.3 10311.9 10312.5 10338.7 7341.0 8319.8 8597.7 8624.5 8639.5 8356.9 8370.2 8415.2 8463.9 8547.5 7705.8 7752.3 7817.1 7819.3 7835.8 5701.8 5781.1 5857.8 5913.7 5971.1 5779.8 5805.8 5918.0 6020.8 6173.1 05:11:51 INFO - PID 1639 | 05:11:51 INFO - PID 1639 | [#4] prototype.html Cycles:180 Average:5134.31 Median:5852.27 stddev:1610.95 (27.5%) stddev-sans-first:1575.01 05:11:51 INFO - PID 1639 | Values: 354.0 366.9 379.7 390.2 401.3 6038.6 6117.6 6120.6 6154.1 6173.4 5772.6 5865.1 5876.6 5940.6 5963.7 3947.5 4024.7 4372.7 4415.8 4425.7 4280.8 4410.8 4437.6 4450.3 4461.4 4306.5 4339.6 4356.4 4371.9 4380.9 4355.5 4362.4 4368.3 4384.6 4386.3 3763.6 3798.8 3814.8 3816.3 3821.1 4799.6 5603.7 5850.2 5904.9 5921.8 5220.8 5226.8 5251.7 5263.7 5267.8 6084.4 6384.9 6395.6 6426.6 6465.9 3763.5 3779.6 4164.5 4264.0 4270.1 5428.5 5508.5 6386.2 6571.5 6742.9 3845.5 4240.9 4345.9 4370.3 4395.8 3898.3 4134.0 4429.1 4451.3 4452.5 4717.9 5031.0 5141.2 5187.1 5196.0 5254.5 5276.2 5881.6 6330.4 6376.4 1432.6 1482.6 1496.5 1501.2 1509.0 830.0 919.0 977.8 998.4 1000.9 5053.9 5537.3 5979.4 5982.3 5993.9 6631.1 6633.5 6639.5 6655.4 6699.8 4712.5 5854.3 5872.0 5967.9 5976.8 3027.8 3310.6 3416.3 3441.0 3457.9 5264.7 5441.5 6208.8 6652.1 6744.6 5595.6 6701.3 6732.9 6746.4 6748.3 6423.2 6728.3 6748.2 6748.7 6753.9 5511.5 6607.9 6623.3 6676.2 6687.0 6547.8 6574.0 6574.3 6595.6 6617.6 5395.9 6417.7 6499.3 6815.9 6820.6 3992.8 4672.9 4844.1 4846.6 4852.9 6442.7 6591.6 6672.9 6724.1 6732.3 6434.1 6441.5 6443.6 6464.7 6466.4 5356.5 6061.5 6404.9 6431.5 6459.5 5206.8 6147.8 6207.2 6277.7 6297.9 5345.3 5936.6 6426.5 6441.8 6457.5 5517.8 5960.0 6237.1 6250.4 6260.2 05:11:51 INFO - PID 1639 | 05:11:51 INFO - PID 1639 | [#5] yui.html Cycles:180 Average:19262.51 Median:18099.62 stddev:27906.98 (154.2%) stddev-sans-first:27950.53 05:11:51 INFO - PID 1639 | Values: 718.6 719.2 738.4 745.4 768.9 15429.5 15680.2 16513.9 16569.5 16577.8 14659.1 15130.5 15157.7 15282.0 15326.1 976.5 1003.3 1006.0 1007.3 1011.6 983.6 992.0 997.7 997.9 1000.7 1007.0 1064.1 1067.7 1069.7 1070.0 1053.5 1056.3 1057.0 1057.8 1064.4 788.2 790.4 790.6 791.5 795.7 16780.7 17172.4 17233.7 17319.0 17433.9 12657.0 12791.0 13246.7 14806.6 15017.8 11249.3 11481.7 11698.2 11703.1 12052.5 3065.8 3075.2 3093.9 3127.4 3193.2 84158.5 107904.0 109207.0 110542.9 111477.4 11577.7 11716.3 11726.3 11734.8 12046.7 25128.2 25217.2 25397.5 25448.5 25486.1 8161.3 8240.2 8292.3 8307.8 8311.8 4105.7 4111.0 4202.3 4250.9 4252.2 4058.4 4190.2 4220.5 4225.2 4229.3 824.6 825.9 837.0 839.0 853.4 527.8 554.4 573.9 576.7 578.8 9714.7 10293.9 10376.9 10430.7 10542.5 538.2 586.5 587.6 593.1 594.2 3587.1 3690.9 4310.9 4677.3 4701.3 96568.1 98437.5 99345.5 101098.5 101152.0 89207.6 89531.6 90477.5 91091.0 91194.0 71702.0 71813.0 72908.3 73571.3 74073.6 9349.1 9354.8 9361.2 9406.0 9416.7 39130.8 39185.6 39555.2 39778.8 40166.8 33006.0 41489.4 51371.2 51455.0 52053.0 11574.7 11650.1 11903.8 11987.5 12547.2 12956.7 12970.7 13043.7 13136.1 13168.6 11679.8 11813.8 11849.7 11885.9 12238.3 11877.0 12131.7 12227.2 12269.3 12465.2 11580.2 11619.2 12086.3 12266.4 12362.2 8565.6 8634.3 8797.6 8817.6 9266.8 6770.1 8462.3 9642.1 9782.6 10107.8 05:11:51 INFO - PID 1639 | -------- Summary: end -------- 05:11:51 INFO - PID 1639 | 05:11:51 INFO - TEST-INFO | 1639: exit 0 05:11:51 INFO - TEST-OK | dromaeo_css | took 1120406ms 05:11:51 INFO - TEST-START | kraken 05:11:51 INFO - operating with platform_type : mac_ 05:11:51 INFO - Initialising browser for kraken test... 05:11:51 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/tmpKdDfVI/profile http://localhost:49241/getInfo.html) 05:11:54 INFO - PID 1648 | __metrics Screen width/height:1600/1200 05:11:54 INFO - PID 1648 | colorDepth:24 05:11:54 INFO - PID 1648 | Browser inner width/height: 1024/689 05:11:54 INFO - PID 1648 | __metrics 05:11:54 INFO - PID 1648 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:11:54 INFO - PID 1648 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:11:55 INFO - TEST-INFO | 1648: exit 0 05:11:55 INFO - Browser initialized. 05:11:55 INFO - Running cycle 1/1 for kraken test... 05:11:55 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/tmpKdDfVI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:12:07 INFO - PID 1649 | RSS: Main: 232267776 05:12:07 INFO - PID 1649 | 05:12:10 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 05:12:11 INFO - PID 1649 | RSS: Main: 286199808 05:12:11 INFO - PID 1649 | 05:12:13 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 05:12:14 INFO - PID 1649 | RSS: Main: 286674944 05:12:14 INFO - PID 1649 | 05:12:18 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 05:12:18 INFO - PID 1649 | RSS: Main: 380960768 05:12:18 INFO - PID 1649 | 05:12:20 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 05:12:21 INFO - PID 1649 | RSS: Main: 283086848 05:12:21 INFO - PID 1649 | 05:12:23 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:12:24 INFO - PID 1649 | RSS: Main: 284291072 05:12:24 INFO - PID 1649 | 05:12:27 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 05:12:28 INFO - PID 1649 | RSS: Main: 326426624 05:12:28 INFO - PID 1649 | 05:12:31 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 05:12:31 INFO - PID 1649 | RSS: Main: 333897728 05:12:31 INFO - PID 1649 | 05:12:35 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 05:12:35 INFO - PID 1649 | RSS: Main: 336117760 05:12:35 INFO - PID 1649 | 05:12:37 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:12:37 INFO - PID 1649 | RSS: Main: 305668096 05:12:37 INFO - PID 1649 | 05:12:39 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:12:40 INFO - PID 1649 | RSS: Main: 309248000 05:12:40 INFO - PID 1649 | 05:12:42 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:12:43 INFO - PID 1649 | RSS: Main: 311255040 05:12:43 INFO - PID 1649 | 05:12:46 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:12:47 INFO - PID 1649 | RSS: Main: 328019968 05:12:47 INFO - PID 1649 | 05:12:50 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:12:51 INFO - PID 1649 | RSS: Main: 311570432 05:12:51 INFO - PID 1649 | 05:12:53 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 05:12:53 INFO - PID 1649 | RSS: Main: 377430016 05:12:53 INFO - PID 1649 | 05:12:53 INFO - PID 1649 | __start_tp_report 05:12:53 INFO - PID 1649 | _x_x_mozilla_page_load 05:12:53 INFO - PID 1649 | _x_x_mozilla_page_load_details 05:12:53 INFO - PID 1649 | |i|pagename|runs| 05:12:53 INFO - PID 1649 | |0;ai-astar;112;123;122;122;124;124;119;123;104;166 05:12:53 INFO - PID 1649 | |1;audio-beat-detection;162;157;150;162;118;118;117;116;144;118 05:12:53 INFO - PID 1649 | |2;audio-dft;218;214;214;212;212;218;211;213;210;215 05:12:53 INFO - PID 1649 | |3;audio-fft;84;65;64;97;77;66;62;62;114;94 05:12:53 INFO - PID 1649 | |4;audio-oscillator;95;78;106;112;113;94;93;75;77;92 05:12:53 INFO - PID 1649 | |5;imaging-gaussian-blur;91;91;91;94;134;91;92;91;91;90 05:12:53 INFO - PID 1649 | |6;imaging-darkroom;97;100;100;101;100;100;100;101;100;98 05:12:53 INFO - PID 1649 | |7;imaging-desaturate;102;101;100;100;100;101;104;101;101;102 05:12:53 INFO - PID 1649 | |8;json-parse-financial;51;52;50;52;52;52;53;53;53;52 05:12:53 INFO - PID 1649 | |9;json-stringify-tinderbox;58;68;75;69;68;63;64;65;66;66 05:12:53 INFO - PID 1649 | |10;stanford-crypto-aes;92;93;92;90;92;91;90;90;88;90 05:12:53 INFO - PID 1649 | |11;stanford-crypto-ccm;152;155;149;147;162;153;151;153;194;165 05:12:53 INFO - PID 1649 | |12;stanford-crypto-pbkdf2;204;201;206;203;209;246;253;226;201;200 05:12:53 INFO - PID 1649 | |13;stanford-crypto-sha256-iterative;73;76;80;99;101;104;74;77;105;104 05:12:53 INFO - PID 1649 | __end_tp_report 05:12:53 INFO - PID 1649 | __start_cc_report 05:12:53 INFO - PID 1649 | _x_x_mozilla_cycle_collect,2230 05:12:53 INFO - PID 1649 | __end_cc_report 05:12:53 INFO - PID 1649 | __startTimestamp1491307973607__endTimestamp 05:12:53 INFO - PID 1649 | 05:12:53 INFO - PID 1649 | ------- Summary: start ------- 05:12:53 INFO - PID 1649 | Number of tests: 14 05:12:53 INFO - PID 1649 | 05:12:53 INFO - PID 1649 | [#0] ai-astar Cycles:10 Average:123.90 Median:123.00 stddev:16.13 (13.1%) stddev-sans-first:16.53 05:12:53 INFO - PID 1649 | Values: 112.0 123.0 122.0 122.0 124.0 124.0 119.0 123.0 104.0 166.0 05:12:53 INFO - PID 1649 | 05:12:53 INFO - PID 1649 | [#1] audio-beat-detection Cycles:10 Average:136.20 Median:147.00 stddev:20.51 (14.0%) stddev-sans-first:19.51 05:12:53 INFO - PID 1649 | Values: 162.0 157.0 150.0 162.0 118.0 118.0 117.0 116.0 144.0 118.0 05:12:53 INFO - PID 1649 | 05:12:53 INFO - PID 1649 | [#2] audio-dft Cycles:10 Average:213.70 Median:214.00 stddev:2.71 (1.3%) stddev-sans-first:2.39 05:12:53 INFO - PID 1649 | Values: 218.0 214.0 214.0 212.0 212.0 218.0 211.0 213.0 210.0 215.0 05:12:53 INFO - PID 1649 | 05:12:53 INFO - PID 1649 | [#3] audio-fft Cycles:10 Average:78.50 Median:71.50 stddev:18.16 (25.4%) stddev-sans-first:19.15 05:12:53 INFO - PID 1649 | Values: 84.0 65.0 64.0 97.0 77.0 66.0 62.0 62.0 114.0 94.0 05:12:53 INFO - PID 1649 | 05:12:53 INFO - PID 1649 | [#4] audio-oscillator Cycles:10 Average:93.50 Median:85.00 stddev:13.90 (16.4%) stddev-sans-first:14.73 05:12:53 INFO - PID 1649 | Values: 95.0 78.0 106.0 112.0 113.0 94.0 93.0 75.0 77.0 92.0 05:12:53 INFO - PID 1649 | 05:12:53 INFO - PID 1649 | [#5] imaging-gaussian-blur Cycles:10 Average:95.60 Median:91.00 stddev:13.53 (14.9%) stddev-sans-first:14.25 05:12:53 INFO - PID 1649 | Values: 91.0 91.0 91.0 94.0 134.0 91.0 92.0 91.0 91.0 90.0 05:12:53 INFO - PID 1649 | 05:12:53 INFO - PID 1649 | [#6] imaging-darkroom Cycles:10 Average:99.70 Median:100.50 stddev:1.25 (1.2%) stddev-sans-first:0.87 05:12:53 INFO - PID 1649 | Values: 97.0 100.0 100.0 101.0 100.0 100.0 100.0 101.0 100.0 98.0 05:12:53 INFO - PID 1649 | 05:12:53 INFO - PID 1649 | [#7] imaging-desaturate Cycles:10 Average:101.20 Median:101.00 stddev:1.23 (1.2%) stddev-sans-first:1.27 05:12:53 INFO - PID 1649 | Values: 102.0 101.0 100.0 100.0 100.0 101.0 104.0 101.0 101.0 102.0 05:12:53 INFO - PID 1649 | 05:12:53 INFO - PID 1649 | [#8] json-parse-financial Cycles:10 Average:52.00 Median:52.00 stddev:0.94 (1.8%) stddev-sans-first:0.93 05:12:53 INFO - PID 1649 | Values: 51.0 52.0 50.0 52.0 52.0 52.0 53.0 53.0 53.0 52.0 05:12:53 INFO - PID 1649 | 05:12:53 INFO - PID 1649 | [#9] json-stringify-tinderbox Cycles:10 Average:66.20 Median:67.00 stddev:4.42 (6.6%) stddev-sans-first:3.55 05:12:53 INFO - PID 1649 | Values: 58.0 68.0 75.0 69.0 68.0 63.0 64.0 65.0 66.0 66.0 05:12:53 INFO - PID 1649 | 05:12:53 INFO - PID 1649 | [#10] stanford-crypto-aes Cycles:10 Average:90.80 Median:91.50 stddev:1.48 (1.6%) stddev-sans-first:1.50 05:12:53 INFO - PID 1649 | Values: 92.0 93.0 92.0 90.0 92.0 91.0 90.0 90.0 88.0 90.0 05:12:53 INFO - PID 1649 | 05:12:53 INFO - PID 1649 | [#11] stanford-crypto-ccm Cycles:10 Average:158.10 Median:154.00 stddev:13.77 (8.9%) stddev-sans-first:14.43 05:12:53 INFO - PID 1649 | Values: 152.0 155.0 149.0 147.0 162.0 153.0 151.0 153.0 194.0 165.0 05:12:53 INFO - PID 1649 | 05:12:53 INFO - PID 1649 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:214.90 Median:207.50 stddev:19.79 (9.5%) stddev-sans-first:20.59 05:12:53 INFO - PID 1649 | Values: 204.0 201.0 206.0 203.0 209.0 246.0 253.0 226.0 201.0 200.0 05:12:53 INFO - PID 1649 | 05:12:53 INFO - PID 1649 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:89.30 Median:75.00 stddev:14.24 (19.0%) stddev-sans-first:13.82 05:12:53 INFO - PID 1649 | Values: 73.0 76.0 80.0 99.0 101.0 104.0 74.0 77.0 105.0 104.0 05:12:53 INFO - PID 1649 | -------- Summary: end -------- 05:12:53 INFO - PID 1649 | 05:12:54 INFO - TEST-INFO | 1649: exit 0 05:12:54 INFO - TEST-OK | kraken | took 62837ms 05:12:54 INFO - SUITE-END | took 1183s 05:12:54 INFO - Completed test suite (00:19:43) 05:12:54 INFO - javascript benchmark 05:12:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7548.812006702856, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3480.982595087024, 3485.0938755923453, 3489.4591338342566, 3520.630333814949, 3568.357695614788, 6002.219711437507, 6099.612447337997, 6191.226096737908, 6208.379162083789, 6220.346863579327, 5026.9497305026935, 6089.269287685473, 6141.1095391168255, 6177.135201071854, 6181.690915454221, 4768.47546769855, 5196.0, 5245.9213111803165, 5326.467353264681, 5444.700541470217, 5419.241306217133, 5422.078246698071, 5426.593005524602, 5430.83707488776, 5459.617826752129, 5194.506521880416, 5290.312259406252, 5301.549368303698, 5317.468253174651, 5366.758495867676, 5310.0, 5328.573714102862, 5386.245925570423, 5403.324584426947, 5410.431904649994, 5313.149896016619, 5323.627346085776, 5330.626856120073, 5336.4129945705945, 5392.379876314235, 5988.490978266853, 6019.729112189962, 6169.84575385619, 6173.197484327009, 6187.783427580058, 6347.904781428282, 6503.902441463382, 6584.440322572587, 6599.142111525519, 6601.7359305627715, 5570.526505247059, 6727.66361681914, 6731.932680673229, 6745.831354216135, 6750.426213771835, 6207.503399728011, 6342.9851223804435, 6344.016677414962, 6359.872802543923, 6364.395382438661, 6454.870902581922, 6550.115734375799, 6778.93221067783, 6831.795046148623, 6867.107276054081, 6254.437100660872, 6313.968430157912, 6329.082283069021, 6497.837554061091, 6541.313162117909, 5585.720713964285, 5618.887622247532, 6569.934300657028, 6695.062691223233, 6716.3955244028275, 6540.9345906541275, 6542.771003014872, 6559.8032059038305, 6602.141721576164, 6664.766733164316, 6251.99968005117, 6287.654179020198, 6294.370562943669, 6496.317886621931, 6558.704858281389, 5274.208868669653, 5285.471452854761, 5291.074062039128, 5293.708846013429, 5310.946890531122, 4667.603253723403, 4680.438347398334, 4704.788284527204, 4755.667103302805, 4766.666333356632, 6198.969005154945, 6217.751289948442, 6261.467775239064, 6271.43557079865, 6274.780382686584, 6326.715297811609, 6405.263394709575, 6428.77499287532, 6600.141981542369, 6716.29478904708, 6284.811455656246, 6302.810915672537, 6304.464120549713, 6304.716287767062, 6313.305536391085, 5744.454276843693, 5780.1907732917425, 5809.0, 5823.838847198972, 5868.207791948118, 6504.4796416285635, 6564.868702626016, 6591.439727623014, 6854.0, 6879.724811007503, 5746.224259724883, 6004.0, 6351.587146835441, 6647.0, 6676.532642714963, 6646.468282537482, 6820.863582728417, 6840.623765692934, 6847.21257055425, 6864.553804002724, 6241.407066328691, 6439.581427207217, 6537.248216455168, 6554.770583029571, 6574.0796288520605, 6427.614343139427, 6579.309172536815, 6603.372679595431, 6673.9332606673315, 6694.330566943461, 6430.710618022294, 6446.194225721785, 6457.4511166551365, 6489.4808415325715, 6503.2846386898345, 5612.747426365741, 6233.0, 6241.875162496815, 6308.0, 6345.619262844244, 6281.12064311006, 6295.433410993032, 6298.0, 6307.05394190875, 6308.148399965946, 6225.719842607185, 6300.9684951574945, 6319.936800631935, 6364.4908407326375, 6367.872642547216, 6215.875682486235, 6270.49836013127, 6295.527835412271, 6301.275353334425, 6308.211473565804], "value": 5989.194542026206, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [749.5914726474072, 795.7214974758836, 813.0974618173826, 1009.439760932682, 1116.5924437580281, 27836.0, 28287.717122828766, 36984.0, 37456.81271593645, 37537.812310938476, 39629.801850990705, 39757.60242397575, 39799.602003979955, 39896.0, 39919.800400997956, 8527.445716028438, 8717.041125476224, 8744.30045596354, 8754.781130471725, 8761.16768906956, 6134.4478996890275, 6302.401271879165, 7438.404927605806, 8441.620127094295, 8731.388802783807, 8550.059493455716, 8678.262347700453, 8679.869801952977, 8686.131386861327, 8689.391742578022, 8577.142285771435, 8649.351298652626, 8658.177473140042, 8669.08974557675, 8671.826563468758, 8505.957470212672, 8567.742967710916, 8573.52845593492, 8576.914230857674, 8591.527465989368, 37450.62549374526, 37458.0, 37647.0, 37742.0, 37960.0, 2982.9552556711665, 3027.3700595695577, 3041.58938543296, 3057.159281197666, 3066.294752207005, 27847.72152278492, 28251.85874070637, 28452.430951380855, 28464.857675711697, 29447.852760736274, 2831.490331740286, 2832.2636114610145, 2855.957160642571, 2867.440849034439, 2898.4637841999297, 353252.4674753245, 353798.0, 355745.0, 356063.0, 358497.0, 51583.226251605505, 51949.740251299256, 51983.0, 52001.69995750137, 52003.0, 54369.1844622331, 54556.90886182254, 54584.90830183374, 54685.0, 54763.45236547663, 12780.424880880382, 12960.611181664564, 12962.80555791664, 12985.675358116123, 12997.805032924514, 10239.0, 10243.180545556337, 10257.17942564593, 10270.435126067989, 10306.690799276033, 11753.941230293965, 12002.759944801055, 12007.979321757748, 12011.0, 12018.33899135556, 5673.914891276634, 5907.734151963172, 5943.435373639497, 5964.910526342108, 5968.612040217372, 958.6117622362954, 985.5170966226498, 992.5136683025265, 1041.9010194031555, 1045.749020235138, 22998.8850055752, 24178.87910560436, 24182.0, 24214.87892560526, 24286.90708918103, 1075.58589942871, 1076.9353838769541, 1125.358545629, 1128.2553514680435, 1139.2708666453477, 11467.139964502529, 12058.216215945935, 12259.57091501811, 12417.813732794015, 12436.0, 482751.0, 485628.0, 486698.0, 488445.80879338103, 489811.7547061352, 53011.73494132505, 53385.46614533805, 53460.93078138493, 53512.46487535075, 53527.46472535303, 1311.2591385867336, 1411.7600007998665, 1493.3429291111877, 1505.0593379138038, 1510.3731951240331, 22871.0, 23432.88283558571, 23468.76531234734, 23531.294061178192, 23559.646605301277, 36962.26075478529, 37058.8147059263, 37087.0, 37108.88673339804, 37139.28607139264, 418328.0, 418388.90805545775, 419329.0, 421496.0, 421633.0, 33308.000759977236, 33620.0, 34190.65809341974, 34327.65672343344, 34350.65649343475, 42227.788861055495, 42572.0, 42916.0, 42935.57064429441, 43066.0, 27982.72017279801, 28196.577051344655, 29697.554536681535, 30035.0, 30339.87620866518, 23782.207871680374, 26500.73499264983, 27096.72903270942, 29598.260043499085, 29955.70044299529, 35258.47112293369, 35364.29271414609, 35419.82290088533, 36340.0, 36484.45273320955, 28993.85503072471, 29461.0, 29999.850000749855, 30214.54678179873, 30647.007944483536, 20549.075291611614, 22865.50723199405, 23273.53452930898, 23633.763662363155, 24187.395315117265], "value": 17489.766056048913, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.4247943126446, 392.74275349645956, 414.77602094868774, 426.27745970579866, 426.5031238607022, 13381.665458363546, 15481.303341349638, 21120.0495977681, 22000.44998875029, 22141.44646383839, 21615.1353945842, 21808.563828723418, 21814.018369173424, 22161.33515994523, 22176.667349989762, 5919.082542205965, 5945.405459454052, 6090.147379366892, 6164.907526387108, 6172.84567885802, 3631.909202269938, 3808.9619103809023, 6002.309734380558, 6129.938700613004, 6142.508599312045, 3821.0, 4480.798364073608, 5253.763580638862, 6106.572539922207, 6112.419320164599, 6036.456718895277, 6104.08438734189, 6107.4808641265545, 6115.266168059861, 6115.663638499903, 5197.0, 5422.2951016368015, 5422.376426710939, 5426.891462170774, 5427.728613569306, 25763.613545796827, 26370.472590548274, 26457.47085058307, 26542.07102751414, 26759.73240267592, 2048.6107639548586, 2054.866433681806, 2064.1743302678897, 2099.8320134389214, 2154.3859999899955, 15739.213039347987, 15999.440019599258, 16108.919455402765, 16209.270582823683, 16781.748273775902, 1803.5491127218195, 1847.7136043913215, 1884.3969929622526, 1891.9432417027374, 1903.1055403960117, 138331.0, 143063.0, 144327.0, 145465.0, 147148.0, 9677.467739274407, 11711.824322635168, 11833.526658933546, 11840.940795295968, 11877.762444751057, 15617.297221625055, 15623.375064997274, 15681.68636627261, 15684.76472852908, 15738.9213053934, 7143.42852571793, 7808.609569521501, 7849.372050235967, 8106.554139522383, 8203.466774659628, 6226.439620434183, 7464.0, 7644.770656880302, 7652.464327497133, 7657.310842024244, 7177.7487787927175, 7312.415006799443, 7335.486515943832, 7351.22812104732, 7352.301531354513, 2050.6513892638286, 2068.813806757399, 2069.172331067585, 2073.859377342486, 2074.686724302392, 901.2024358442825, 931.2456909903, 944.1313991128178, 961.3174646001418, 977.4917043137671, 16579.67362610988, 19514.804851951583, 20252.898735506522, 20325.18699252043, 20457.693134602992, 951.3720944176948, 956.8565564150773, 975.3367709957297, 989.0653332600767, 992.1021475564481, 10294.0, 10382.688519344432, 10429.530671119817, 10494.898035706294, 10531.89468105309, 675174.0, 679832.0, 691412.0, 723935.0, 727713.0, 112353.75292494104, 138714.0, 142507.287463562, 149377.0, 153287.0, 1144.7767685301287, 1174.7767924094394, 1196.222455403977, 1199.8560172779148, 1200.8318835363057, 18505.72241416407, 18941.242350305834, 19655.606887861875, 19714.60570788605, 20789.376318710463, 60957.695211523656, 61408.69295653672, 61636.0, 62159.0, 62682.0, 65046.0, 86488.70266945875, 89451.0, 92812.53593731989, 93980.0, 8441.451305665112, 8546.615402306787, 8703.95648021756, 8772.605232764668, 8775.868361974448, 13518.05373623837, 13699.520516781864, 13731.519396821062, 14109.082909610843, 14150.150990940576, 11543.88456115428, 11689.5149103988, 11809.173357864867, 11878.0, 11966.282023078644, 9671.613135474783, 11004.449777511252, 11027.503762330554, 11191.832122518332, 11394.658160255205, 11606.825897611374, 11646.767064658829, 12004.039676825658, 12159.696007599881, 12165.0, 8434.24091831738, 8609.450298946249, 8614.65541378338, 8690.566056600843, 8986.0, 11570.132240081859, 11622.244554103956, 11890.405479726152, 12024.819627705767, 12085.335306558223], "value": 10085.295823702638, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1359.918404895706, 1423.3452611798573, 1446.7540518111916, 1451.2671101093947, 1451.8983671143023, 10395.584176632925, 10837.729056773585, 10856.78286434271, 10860.34837909726, 10878.564857405694, 10467.214958878076, 10592.152627789777, 10741.785164296709, 10843.6746897593, 10847.51186196621, 2411.3850968003135, 2478.095495144268, 2478.6653801736807, 2486.78862296705, 2488.8382255153356, 2419.2621250518587, 2430.0, 2481.5161043596504, 2483.8261321707487, 2483.913063042794, 2361.2916125162383, 2462.5813611685967, 2466.235467005234, 2469.197510808994, 2471.7630544357294, 2424.3090719144957, 2433.245693834917, 2443.462438263588, 2472.4189815393456, 2474.418511649761, 2421.176799888029, 2424.090965887792, 2433.6227884677905, 2438.3416477550963, 2439.1950656283384, 8672.956635216846, 10896.182786290981, 10912.0, 10912.23614346996, 10922.29005114665, 6182.165407669952, 6422.518311126684, 6433.131527243809, 6434.742610295582, 6445.162128923257, 3592.5750118669794, 3701.870434534805, 3796.8101594920145, 4008.7995600219874, 4021.577734337882, 1187.928724276546, 1526.5344070058627, 1565.3503795924678, 1594.9681006379924, 1640.9425670101489, 14884.181370024644, 15059.623509412242, 15217.0, 15220.695586088215, 15245.237738112939, 4968.503149685075, 5474.151506516497, 5624.156376543551, 5655.293088363955, 5767.913481297784, 12643.051771117203, 12662.113652044269, 12663.0, 12691.49234030647, 12698.492060317669, 6396.328385519547, 6404.071409645669, 6408.551401401857, 6418.550701450947, 6423.710933007932, 5672.546196304285, 5806.303243610793, 5863.120531920161, 5904.7933322334375, 5920.141579470953, 4220.894477638022, 4362.781860906942, 4383.912321753547, 4413.558644135561, 4455.287154055401, 1339.5177736015028, 1393.4635165461168, 1402.4670625162373, 1409.2108419285232, 1414.6702100025943, 742.2317900972467, 748.8988986486754, 777.7161336112391, 784.9175836537196, 805.3235282362726, 5841.532677385799, 5863.794767183128, 5979.730912108966, 6030.7286172121485, 6036.245469316335, 565.2453973944747, 589.9085641725453, 596.9582129250911, 602.5781952633174, 604.9866473656607, 3469.254110366233, 4029.657479114308, 4082.775447350424, 4117.958820411817, 4201.747895126302, 13132.409041593151, 13790.310484475736, 13809.585712428643, 13830.962677799205, 13833.723325533432, 12118.515259389702, 12562.246265224116, 13699.794503082461, 13700.725985480234, 13713.520026799015, 8659.0, 9770.267229957639, 9934.105930466438, 9980.451075190935, 10172.440515771703, 5105.7702403391195, 6585.5719378240265, 6666.500012498985, 6795.592264464148, 6812.318768123347, 11776.234544754563, 12235.69410764738, 12247.938760306142, 12276.0, 12401.00791936661, 11162.944185279022, 11445.912638299349, 12272.570460033856, 12513.436895339913, 12546.811797823222, 7949.920500794918, 8264.669413223644, 8759.343049271203, 9142.817143657223, 9189.218916392181, 7778.37772978149, 9974.301798874008, 10311.896881031094, 10312.48437578103, 10338.741531461774, 7341.0, 8319.792005199919, 8597.699080532151, 8624.533829248918, 8639.481631102153, 8356.916430835858, 8370.246677799027, 8415.242628163494, 8463.942007249094, 8547.52988585609, 7705.807354816175, 7752.341051010727, 7817.140114587277, 7819.296263336099, 7835.764927052198, 5701.800436984686, 5781.103928891029, 5857.824265272048, 5913.733881975236, 5971.0744834550715, 5779.826605201851, 5805.796797112081, 5918.0, 6020.849478763066, 6173.135760993554], "value": 5134.459609552513, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.98584056637736, 366.9101070237792, 379.68865530265174, 390.1708868654108, 401.3357892687602, 6038.580933480628, 6117.602355846872, 6120.632762034275, 6154.107654390111, 6173.413525715061, 5772.5670574706955, 5865.149553314767, 5876.588638795286, 5940.594059405937, 5963.731632076556, 3947.4868267125235, 4024.678025757947, 4372.737635741865, 4415.757133357664, 4425.734455932638, 4280.807363668627, 4410.75740834254, 4437.557793717038, 4450.265706158496, 4461.39771130898, 4306.547812479692, 4339.566043395651, 4356.411884395614, 4371.907023244189, 4380.934285985712, 4355.542668019844, 4362.411074504965, 4368.322909948963, 4384.605385515319, 4386.320120381346, 3763.6048214937587, 3798.791066491342, 3814.7901865397394, 3816.313063648542, 3821.1211421372964, 4799.552228363525, 5603.719814009324, 5850.18644220293, 5904.852378690524, 5921.792737254218, 5220.817271395483, 5226.764795584208, 5251.658642188284, 5263.710495922723, 5267.789288428458, 6084.421979911901, 6384.93615063848, 6395.552311338208, 6426.646534440604, 6465.935340646627, 3763.473113764075, 3779.640934111255, 4164.5210800757695, 4264.040590867061, 4270.103278311558, 5428.5114339708825, 5508.476694713996, 6386.168299020597, 6571.507136964747, 6742.932570674279, 3845.4808600839087, 4240.91518169641, 4345.891352716208, 4370.300751879684, 4395.7582332972, 3898.2983063048355, 4134.0, 4429.136318417877, 4451.3323001550025, 4452.510223875371, 4717.882052948635, 5030.974845125751, 5141.151709967813, 5187.118189907725, 5196.0, 5254.474552544715, 5276.150878525553, 5881.647101173943, 6330.398612131932, 6376.39424254695, 1432.5702289313165, 1482.606350030989, 1496.5435542159528, 1501.159350763576, 1508.954731358061, 830.0, 918.9724308270762, 977.7702239973601, 998.3810037776625, 1000.8690180096445, 5053.9241911371355, 5537.314402514777, 5979.431953964367, 5982.316799040842, 5993.910091348634, 6631.115464772839, 6633.502487313471, 6639.468842492589, 6655.367740064686, 6699.794037073276, 4712.481627021025, 5854.347026607978, 5872.0, 5967.880642387128, 5976.834517269091, 3027.819150531295, 3310.553075334847, 3416.3338149060696, 3440.9655903441144, 3457.896263112111, 5264.684118952875, 5441.510264076173, 6208.771438851772, 6652.135222421151, 6744.62904540255, 5595.636283641632, 6701.29636388182, 6732.932670673231, 6746.446148849605, 6748.29142939994, 6423.164988551458, 6728.259891411941, 6748.223954245324, 6748.696308666122, 6753.885608874579, 5511.476409741229, 6607.867842643024, 6623.271440141677, 6676.232233293234, 6687.0, 6547.836304092436, 6574.046763219402, 6574.342565743387, 6595.571287866273, 6617.636030018202, 5395.919061214164, 6417.711202995783, 6499.252585952676, 6815.931840681728, 6820.556663816836, 3992.784004877321, 4672.906541869075, 4844.128056949783, 4846.636502262274, 4852.878678033077, 6442.710078046593, 6591.637459939558, 6672.899906501503, 6724.125863637696, 6732.3267673232285, 6434.06706027614, 6441.516886233645, 6443.613383197023, 6464.709088090953, 6466.351080474449, 5356.491133342326, 6061.545384096122, 6404.9039264412, 6431.48548116159, 6459.515536334699, 5206.843794686166, 6147.754089836357, 6207.193064901534, 6277.654728989767, 6297.937020629735, 5345.278387417804, 5936.554758393224, 6426.485881129405, 6441.806745797634, 6457.547971642128, 5517.841253336845, 5959.970200148971, 6237.064440333805, 6250.3749625037135, 6260.248770147429], "value": 4626.797744797407, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [718.633496916573, 719.208870242733, 738.3834498194009, 745.4446437404134, 768.8692922203228, 15429.537113886587, 15680.215989200522, 16513.917430412832, 16569.50291491256, 16577.75133372999, 14659.12045277284, 15130.54608361748, 15157.696846063072, 15282.00666956647, 15326.080435173897, 976.5166242709851, 1003.2926786615419, 1006.0191313469383, 1007.2999265510473, 1011.6206422591529, 983.5967253426097, 992.0030369478663, 997.725625452999, 997.930144889858, 1000.6647772996055, 1006.954687039085, 1064.084886997182, 1067.674359320407, 1069.6684027951321, 1070.0262760887595, 1053.5048527192207, 1056.2553399853161, 1056.9682909512726, 1057.7937302226069, 1064.435849000031, 788.2393490281848, 790.3953475591177, 790.6363072986433, 791.5211297165247, 795.7016118955391, 16780.748288775678, 17172.39896603613, 17233.741493877602, 17319.047452390114, 17433.912830435893, 12657.0, 12791.026627292318, 13246.735065298737, 14806.555803325917, 15017.849821501755, 11249.325040497515, 11481.655550333504, 11698.181127321091, 11703.122265830012, 12052.45763940616, 3065.7853950223493, 3075.169704179881, 3093.876244950199, 3127.37452509499, 3193.2495863472063, 84158.47524574272, 107904.0, 109207.0, 110542.89457105487, 111477.44261278723, 11577.6526704199, 11716.297022178696, 11726.296422214524, 11734.823977640342, 12046.698832529082, 25128.24615261545, 25217.243482695547, 25397.492050158893, 25448.49103017929, 25486.107986220763, 8161.347092232607, 8240.175982401712, 8292.295154911779, 8307.750767476986, 8311.750647480585, 4105.651019663303, 4110.979445102756, 4202.306619407825, 4250.851220207278, 4252.192083504125, 4058.3912413138264, 4190.245755763992, 4220.5146408163455, 4225.154969006211, 4229.2598795210715, 824.6083110522574, 825.9050209225895, 837.0, 838.9706360277361, 853.4367317570374, 527.7730575852344, 554.4289381936612, 573.9368669446358, 576.700115939709, 578.7540295374449, 9714.708558743248, 10293.94853025745, 10376.948115259376, 10430.687079387479, 10542.52558634848, 538.1922895514252, 586.5102639296235, 587.5802827543655, 593.1251404178802, 594.1622312539299, 3587.0852932502044, 3690.8523659053335, 4310.870673879788, 4677.298405239241, 4701.294805779092, 96568.06626906482, 98437.50781246192, 99345.50327248317, 101098.494507527, 101152.0, 89207.55396223108, 89531.55234223788, 90477.54761226283, 91091.0, 91194.0, 71702.0, 71813.0, 72908.27091729015, 73571.26428735751, 74073.62963185257, 9349.06722618202, 9354.766130846783, 9361.204297634506, 9405.99988024201, 9416.717498475056, 39130.82607521779, 39185.608143918194, 39555.2088958225, 39778.80110599429, 40166.799166003984, 33006.0, 41489.37765933574, 51371.22943155781, 51455.0, 52053.0, 11574.71063223426, 11650.126240532163, 11903.821442678194, 11987.460564274803, 12547.247165169754, 12956.740865182832, 12970.675733106747, 13043.673908152372, 13136.138342325696, 13168.60494185176, 11679.766404671689, 11813.822792657946, 11849.703757406134, 11885.940570297093, 12238.265704057429, 11877.0, 12131.696707582028, 12227.205231659913, 12269.263844169378, 12465.189762665397, 11580.189386742848, 11619.244749091282, 12086.335251561248, 12266.448009839758, 12362.196457230251, 8565.614547345509, 8634.349003004383, 8797.648094076165, 8817.603207855534, 9266.814663706822, 6770.052192692929, 8462.280706140047, 9642.132208101304, 9782.60326719364, 10107.79784404293], "value": 7372.635720469704, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1613.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 123.0, 122.0, 122.0, 124.0, 124.0, 119.0, 123.0, 104.0, 166.0], "value": 123.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 157.0, 150.0, 162.0, 118.0, 118.0, 117.0, 116.0, 144.0, 118.0], "value": 136.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [218.0, 214.0, 214.0, 212.0, 212.0, 218.0, 211.0, 213.0, 210.0, 215.0], "value": 213.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 65.0, 64.0, 97.0, 77.0, 66.0, 62.0, 62.0, 114.0, 94.0], "value": 78.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 78.0, 106.0, 112.0, 113.0, 94.0, 93.0, 75.0, 77.0, 92.0], "value": 93.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 91.0, 91.0, 94.0, 134.0, 91.0, 92.0, 91.0, 91.0, 90.0], "value": 95.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 100.0, 100.0, 101.0, 100.0, 100.0, 100.0, 101.0, 100.0, 98.0], "value": 99.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 101.0, 100.0, 100.0, 100.0, 101.0, 104.0, 101.0, 101.0, 102.0], "value": 101.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 52.0, 50.0, 52.0, 52.0, 52.0, 53.0, 53.0, 53.0, 52.0], "value": 52.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 68.0, 75.0, 69.0, 68.0, 63.0, 64.0, 65.0, 66.0, 66.0], "value": 66.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 92.0, 90.0, 92.0, 91.0, 90.0, 90.0, 88.0, 90.0], "value": 90.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 155.0, 149.0, 147.0, 162.0, 153.0, 151.0, 153.0, 194.0, 165.0], "value": 158.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [204.0, 201.0, 206.0, 203.0, 209.0, 246.0, 253.0, 226.0, 201.0, 200.0], "value": 214.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 76.0, 80.0, 99.0, 101.0, 104.0, 74.0, 77.0, 105.0, 104.0], "value": 89.3, "unit": "score"}]}]} 05:12:54 INFO - Return code: 0 05:12:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:12:54 ERROR - # TBPL SUCCESS # 05:12:54 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:12:54 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:12:54 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:12:54 INFO - 2017-04-04 05:12:54.864 screenresolution[1653:9951] starting screenresolution argv=screenresolution get 05:12:54 INFO - 2017-04-04 05:12:54.867 screenresolution[1653:9951] Display 0: 1600x1200x32@60 05:12:54 INFO - 2017-04-04 05:12:54.873 screenresolution[1654:9954] starting screenresolution argv=screenresolution list 05:12:54 INFO - Available Modes on Display 0 05:12:54 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:12:54 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:12:54 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:12:54 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:12:55 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:12:55 INFO - Intel Iris: 05:12:55 INFO - Chipset Model: Intel Iris 05:12:55 INFO - Type: GPU 05:12:55 INFO - Bus: Built-In 05:12:55 INFO - VRAM (Dynamic, Max): 1536 MB 05:12:55 INFO - Vendor: Intel (0x8086) 05:12:55 INFO - Device ID: 0x0a2e 05:12:55 INFO - Revision ID: 0x0009 05:12:55 INFO - Displays: 05:12:55 INFO - Display: 05:12:55 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:12:55 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:12:55 INFO - Display Serial Number: 1600x1200 60 05:12:55 INFO - Main Display: Yes 05:12:55 INFO - Mirror: Off 05:12:55 INFO - Online: Yes 05:12:55 INFO - Rotation: Supported 05:12:55 INFO - Return code: 0 05:12:55 INFO - Running post-action listener: _resource_record_post_action 05:12:55 INFO - [mozharness: 2017-04-04 12:12:55.128997Z] Finished run-tests step (success) 05:12:55 INFO - Running post-run listener: _resource_record_post_run 05:12:55 INFO - Total resource usage - Wall time: 1204s; CPU: 54.0%; Read bytes: 38302720; Write bytes: 515024896; Read time: 243; Write time: 1568 05:12:55 INFO - TinderboxPrint: CPU usage
53.7% 05:12:55 INFO - TinderboxPrint: I/O read bytes / time
38,302,720 / 243 05:12:55 INFO - TinderboxPrint: I/O write bytes / time
515,024,896 / 1,568 05:12:55 INFO - TinderboxPrint: CPU idle
2,229.0 (46.3%) 05:12:55 INFO - TinderboxPrint: CPU system
966.7 (20.1%) 05:12:55 INFO - TinderboxPrint: CPU user
1,621.9 (33.7%) 05:12:55 INFO - TinderboxPrint: Swap in / out
249,643,008 / 0 05:12:55 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 205195776; Write bytes: 202706944; Read time: 15645; Write time: 432 05:12:55 INFO - run-tests - Wall time: 1184s; CPU: 54.0%; Read bytes: 36475904; Write bytes: 299630592; Read time: 228; Write time: 1098 05:12:55 INFO - Running post-run listener: _upload_blobber_files 05:12:55 INFO - Blob upload gear active. 05:12:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:12:55 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 05:12:55 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'] 05:12:55 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 05:12:56 INFO - (blobuploader) - INFO - Open directory for files ... 05:12:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:12:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:12:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:12:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:12:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:12:57 INFO - (blobuploader) - INFO - Done attempting. 05:12:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:12:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:12:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:12:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:12:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:12:59 INFO - (blobuploader) - INFO - Done attempting. 05:12:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:12:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:12:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:13:00 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:13:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:13:00 INFO - (blobuploader) - INFO - Done attempting. 05:13:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:13:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:13:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:13:02 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:13:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:13:02 INFO - (blobuploader) - INFO - Done attempting. 05:13:02 INFO - (blobuploader) - INFO - Iteration through files over. 05:13:02 INFO - Return code: 0 05:13:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:13:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:13:02 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/41c6f4e9cd995b9c4e8df690422dc945c4d039fa4a8a8bb275de5e3bd8fad1eba26c4ea117027850c5ece497ee79ddf9e56b51dcd52855155c08552a98a63f02", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fdf5111a77d8b404a66cec33771ff5092295c23f8b0d0ec96dd5e10b195aca42025a5dcc005269af4fb640733cbbd35e1fc8be1a320819e753b843e759e474b1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/081eaf08ed56b74b41a2a175877a5080f7ca85999043a3daa4ea2dbc0a55844ea901e09af488614262786d17339c7eded9f6f8aa2e6df132f31a4f7b48d3ee74", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6a70c0bfed8f27c018c0b69d73d1aa62d66f4aa3821108e280bf615e319fe980e87d53c0ede32cc6e60039694ebedbb2f98e8daa232406a7f52dbeb85ffadea8"} 05:13:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:13:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:13:02 INFO - Contents: 05:13:02 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/41c6f4e9cd995b9c4e8df690422dc945c4d039fa4a8a8bb275de5e3bd8fad1eba26c4ea117027850c5ece497ee79ddf9e56b51dcd52855155c08552a98a63f02", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fdf5111a77d8b404a66cec33771ff5092295c23f8b0d0ec96dd5e10b195aca42025a5dcc005269af4fb640733cbbd35e1fc8be1a320819e753b843e759e474b1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/081eaf08ed56b74b41a2a175877a5080f7ca85999043a3daa4ea2dbc0a55844ea901e09af488614262786d17339c7eded9f6f8aa2e6df132f31a4f7b48d3ee74", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6a70c0bfed8f27c018c0b69d73d1aa62d66f4aa3821108e280bf615e319fe980e87d53c0ede32cc6e60039694ebedbb2f98e8daa232406a7f52dbeb85ffadea8"} 05:13:02 INFO - Running post-run listener: copy_logs_to_upload_dir 05:13:02 INFO - Copying logs to upload dir... 05:13:02 INFO - mkdir: /builds/slave/test/build/upload/logs 05:13:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1290.324102 ========= master_lag: -0.20 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 30 secs) (at 2017-04-04 05:13:02.762926) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-04 05:13:02.767018) ========= 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.n9e71pItTD/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.kVpnxlNZJP/Listeners TMPDIR=/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/41c6f4e9cd995b9c4e8df690422dc945c4d039fa4a8a8bb275de5e3bd8fad1eba26c4ea117027850c5ece497ee79ddf9e56b51dcd52855155c08552a98a63f02", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fdf5111a77d8b404a66cec33771ff5092295c23f8b0d0ec96dd5e10b195aca42025a5dcc005269af4fb640733cbbd35e1fc8be1a320819e753b843e759e474b1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/081eaf08ed56b74b41a2a175877a5080f7ca85999043a3daa4ea2dbc0a55844ea901e09af488614262786d17339c7eded9f6f8aa2e6df132f31a4f7b48d3ee74", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6a70c0bfed8f27c018c0b69d73d1aa62d66f4aa3821108e280bf615e319fe980e87d53c0ede32cc6e60039694ebedbb2f98e8daa232406a7f52dbeb85ffadea8"} build_url:https://queue.taskcluster.net/v1/task/DD5TEWs3QH215aOaprSWcQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011383 build_url: 'https://queue.taskcluster.net/v1/task/DD5TEWs3QH215aOaprSWcQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/41c6f4e9cd995b9c4e8df690422dc945c4d039fa4a8a8bb275de5e3bd8fad1eba26c4ea117027850c5ece497ee79ddf9e56b51dcd52855155c08552a98a63f02", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fdf5111a77d8b404a66cec33771ff5092295c23f8b0d0ec96dd5e10b195aca42025a5dcc005269af4fb640733cbbd35e1fc8be1a320819e753b843e759e474b1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/081eaf08ed56b74b41a2a175877a5080f7ca85999043a3daa4ea2dbc0a55844ea901e09af488614262786d17339c7eded9f6f8aa2e6df132f31a4f7b48d3ee74", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6a70c0bfed8f27c018c0b69d73d1aa62d66f4aa3821108e280bf615e319fe980e87d53c0ede32cc6e60039694ebedbb2f98e8daa232406a7f52dbeb85ffadea8"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-04 05:13:02.802628) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 05:13:02.802975) ========= 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.n9e71pItTD/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.kVpnxlNZJP/Listeners TMPDIR=/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/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.005194 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 05:13:02.851260) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-04 05:13:02.851591) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-04 05:13:02.851911) ========= ========= Total master_lag: -0.02 =========