builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0175 starttime: 1484397009.24 results: success (0) buildid: 20170114030206 builduid: 4b23be66cb1f4fa1b1b6ef8de844802d revision: ac3275723df59db0f09198fdb61b51e7002c391a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-14 04:30:09.241522) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-14 04:30:09.241991) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-14 04:30:09.242283) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-14 04:30:09.267065) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-01-14 04:30:09.267446) ========= 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.8phl2DXfk2/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.2oCsQKvJYP/Listeners TMPDIR=/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-14 04:30:09-- 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% 8.28M=0.001s 2017-01-14 04:30:11 (8.28 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=2.440804 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-01-14 04:30:11.731671) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-14 04:30:11.731984) ========= 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.8phl2DXfk2/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.2oCsQKvJYP/Listeners TMPDIR=/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/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.019444 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-14 04:30:11.787062) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2017-01-14 04:30:11.787402) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev ac3275723df59db0f09198fdb61b51e7002c391a --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 ac3275723df59db0f09198fdb61b51e7002c391a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.8phl2DXfk2/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.2oCsQKvJYP/Listeners TMPDIR=/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-14 04:30:11,862 truncating revision to first 12 chars 2017-01-14 04:30:11,862 Setting DEBUG logging. 2017-01-14 04:30:11,862 attempt 1/10 2017-01-14 04:30:11,862 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/ac3275723df5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-14 04:30:16,159 unpacking tar archive at: mozilla-central-ac3275723df5/testing/mozharness/ program finished with exit code 0 elapsedTime=4.538221 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2017-01-14 04:30:16.351467) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-14 04:30:16.352080) ========= script_repo_revision: ac3275723df59db0f09198fdb61b51e7002c391a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-14 04:30:16.352545) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-14 04:30:16.352818) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-14 04:30:16.372747) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 25 mins, 16 secs) (at 2017-01-14 04:30:16.373138) ========= /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.8phl2DXfk2/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.2oCsQKvJYP/Listeners TMPDIR=/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/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:30:16 INFO - MultiFileLogger online at 20170114 04:30:16 in /builds/slave/test 04:30:16 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:30:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:30:16 INFO - {'append_to_log': False, 04:30:16 INFO - 'base_work_dir': '/builds/slave/test', 04:30:16 INFO - 'blob_upload_branch': 'Firefox', 04:30:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:30:16 INFO - 'branch': 'Firefox', 04:30:16 INFO - 'buildbot_json_path': 'buildprops.json', 04:30:16 INFO - 'config_files': ('talos/mac_config.py',), 04:30:16 INFO - 'default_actions': ('clobber', 04:30:16 INFO - 'read-buildbot-config', 04:30:16 INFO - 'download-and-extract', 04:30:16 INFO - 'populate-webroot', 04:30:16 INFO - 'create-virtualenv', 04:30:16 INFO - 'install', 04:30:16 INFO - 'run-tests'), 04:30:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:30:16 INFO - 'download_minidump_stackwalk': True, 04:30:16 INFO - 'download_symbols': 'ondemand', 04:30:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:30:16 INFO - 'tooltool.py': '/tools/tooltool.py', 04:30:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:30:16 INFO - '/tools/misc-python/virtualenv.py')}, 04:30:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:30:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:30:16 INFO - 'installer_path': 'installer.exe', 04:30:16 INFO - 'log_level': 'info', 04:30:16 INFO - 'log_name': 'talos', 04:30:16 INFO - 'log_to_console': True, 04:30:16 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:30:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:30:16 INFO - 'opt_config_files': (), 04:30:16 INFO - 'pip_index': False, 04:30:16 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:30:16 INFO - 'cmd': ('bash', 04:30:16 INFO - '-c', 04:30:16 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:30:16 INFO - 'enabled': True, 04:30:16 INFO - 'halt_on_failure': False, 04:30:16 INFO - 'name': 'check_screen_resolution'},), 04:30:16 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:30:16 INFO - 'cmd': ('bash', 04:30:16 INFO - '-c', 04:30:16 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:30:16 INFO - 'enabled': True, 04:30:16 INFO - 'halt_on_failure': False, 04:30:16 INFO - 'name': 'check_screen_resolution'},), 04:30:16 INFO - 'run_cmd_checks_enabled': True, 04:30:16 INFO - 'sps_profile': False, 04:30:16 INFO - 'sps_profile_interval': 0, 04:30:16 INFO - 'suite': 'dromaeojs', 04:30:16 INFO - 'system_bits': '32', 04:30:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:30:16 INFO - 'title': 't-yosemite-r7-0175', 04:30:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:30:16 INFO - 'use_talos_json': True, 04:30:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:30:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:30:16 INFO - 'work_dir': 'build'} 04:30:16 INFO - [mozharness: 2017-01-14 12:30:16.577260Z] Running clobber step. 04:30:16 INFO - Running pre-action listener: _resource_record_pre_action 04:30:16 INFO - Running main action method: clobber 04:30:16 INFO - rmtree: /builds/slave/test/build 04:30:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:30:18 INFO - Running post-action listener: _resource_record_post_action 04:30:18 INFO - [mozharness: 2017-01-14 12:30:18.595805Z] Finished clobber step (success) 04:30:18 INFO - [mozharness: 2017-01-14 12:30:18.595961Z] Running read-buildbot-config step. 04:30:18 INFO - Running pre-action listener: _resource_record_pre_action 04:30:18 INFO - Running main action method: read_buildbot_config 04:30:18 INFO - Using buildbot properties: 04:30:18 INFO - { 04:30:18 INFO - "project": "", 04:30:18 INFO - "product": "firefox", 04:30:18 INFO - "script_repo_revision": "production", 04:30:18 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 04:30:18 INFO - "repository": "", 04:30:18 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 04:30:18 INFO - "buildid": "20170114030206", 04:30:18 INFO - "stage_platform": "macosx64", 04:30:18 INFO - "basedir": "/builds/slave/test", 04:30:18 INFO - "nightly_build": "True", 04:30:18 INFO - "buildnumber": 22, 04:30:18 INFO - "slavename": "t-yosemite-r7-0175", 04:30:18 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 04:30:18 INFO - "platform": "yosemite_r7", 04:30:18 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:30:18 INFO - "branch": "mozilla-central", 04:30:18 INFO - "repo_path": "mozilla-central", 04:30:18 INFO - "revision": "ac3275723df59db0f09198fdb61b51e7002c391a", 04:30:18 INFO - "pgo_build": "False", 04:30:18 INFO - "builduid": "4b23be66cb1f4fa1b1b6ef8de844802d", 04:30:18 INFO - "slavebuilddir": "test" 04:30:18 INFO - } 04:30:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/LhNaBhW-T7-leuif4HywFg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 04:30:18 INFO - Running post-action listener: _resource_record_post_action 04:30:18 INFO - [mozharness: 2017-01-14 12:30:18.599229Z] Finished read-buildbot-config step (success) 04:30:18 INFO - [mozharness: 2017-01-14 12:30:18.599381Z] Running download-and-extract step. 04:30:18 INFO - Running pre-action listener: _resource_record_pre_action 04:30:18 INFO - Running main action method: download_and_extract 04:30:18 INFO - mkdir: /builds/slave/test/build/tests 04:30:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:30:18 INFO - trying https://queue.taskcluster.net/v1/task/LhNaBhW-T7-leuif4HywFg/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 04:30:18 INFO - Downloading https://queue.taskcluster.net/v1/task/LhNaBhW-T7-leuif4HywFg/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 04:30:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LhNaBhW-T7-leuif4HywFg/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 04:30:22 INFO - Downloaded 1199 bytes. 04:30:22 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 04:30:22 INFO - Using the following test package requirements: 04:30:22 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 04:30:22 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:30:22 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 04:30:22 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:30:22 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 04:30:22 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:30:22 INFO - u'jsshell-mac.zip'], 04:30:22 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:30:22 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 04:30:22 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 04:30:22 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:30:22 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 04:30:22 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:30:22 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 04:30:22 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:30:22 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 04:30:22 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:30:22 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 04:30:22 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:30:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LhNaBhW-T7-leuif4HywFg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 04:30:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LhNaBhW-T7-leuif4HywFg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:30:22 INFO - Fetch https://queue.taskcluster.net/v1/task/LhNaBhW-T7-leuif4HywFg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 04:30:24 INFO - Expected file size: 16318170 04:30:24 INFO - Obtained file size: 16318170 04:30:30 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:30:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LhNaBhW-T7-leuif4HywFg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 04:30:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LhNaBhW-T7-leuif4HywFg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:30:30 INFO - Fetch https://queue.taskcluster.net/v1/task/LhNaBhW-T7-leuif4HywFg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 04:31:03 INFO - retry: attempt #1 caught exception: '' 04:31:03 INFO - retry: Failed, sleeping 60 seconds before retrying 04:32:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LhNaBhW-T7-leuif4HywFg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #2 04:32:03 INFO - Fetch https://queue.taskcluster.net/v1/task/LhNaBhW-T7-leuif4HywFg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 04:32:36 INFO - retry: attempt #2 caught exception: '' 04:32:36 INFO - retry: Failed, sleeping 120 seconds before retrying 04:34:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LhNaBhW-T7-leuif4HywFg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #3 04:34:36 INFO - Fetch https://queue.taskcluster.net/v1/task/LhNaBhW-T7-leuif4HywFg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 04:34:38 INFO - Expected file size: 16318170 04:34:38 INFO - Obtained file size: 16318170 04:34:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LhNaBhW-T7-leuif4HywFg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 04:34:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LhNaBhW-T7-leuif4HywFg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:34:44 INFO - Fetch https://queue.taskcluster.net/v1/task/LhNaBhW-T7-leuif4HywFg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 04:34:45 INFO - Expected file size: 14403555 04:34:45 INFO - Obtained file size: 14403555 04:34:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:34:45 INFO - trying https://queue.taskcluster.net/v1/task/LhNaBhW-T7-leuif4HywFg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 04:34:45 INFO - Downloading https://queue.taskcluster.net/v1/task/LhNaBhW-T7-leuif4HywFg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 04:34:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LhNaBhW-T7-leuif4HywFg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 04:34:48 INFO - Downloaded 70132361 bytes. 04:34:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LhNaBhW-T7-leuif4HywFg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 04:34:48 INFO - mkdir: /builds/slave/test/properties 04:34:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:34:48 INFO - Writing to file /builds/slave/test/properties/build_url 04:34:48 INFO - Contents: 04:34:48 INFO - build_url:https://queue.taskcluster.net/v1/task/LhNaBhW-T7-leuif4HywFg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 04:34:49 INFO - Running post-action listener: _resource_record_post_action 04:34:49 INFO - Running post-action listener: set_extra_try_arguments 04:34:49 INFO - [mozharness: 2017-01-14 12:34:49.467753Z] Finished download-and-extract step (success) 04:34:49 INFO - [mozharness: 2017-01-14 12:34:49.467877Z] Running populate-webroot step. 04:34:49 INFO - Running pre-action listener: _resource_record_pre_action 04:34:49 INFO - Running main action method: populate_webroot 04:34:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:34:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:34:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:34:49 INFO - '--tppagecycles', 04:34:49 INFO - '7'], 04:34:49 INFO - 'tests': ['tsvgm']}}, 04:34:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:34:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:34:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:34:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:34:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:34:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:34:49 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:34:49 INFO - 'talos_options': ['--disable-e10s'], 04:34:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:34:49 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:34:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:34:49 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:34:49 INFO - 'talos_options': ['--disable-e10s'], 04:34:49 INFO - 'tests': ['damp', 'tps']}, 04:34:49 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:34:49 INFO - 'tests': ['damp', 'tps']}, 04:34:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:34:49 INFO - 'tests': ['dromaeo_dom']}, 04:34:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:34:49 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:34:49 INFO - 'tests': ['basic_compositor_video']}, 04:34:49 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:34:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:34:49 INFO - 'tests': ['a11yr', 04:34:49 INFO - 'ts_paint', 04:34:49 INFO - 'tpaint', 04:34:49 INFO - 'sessionrestore', 04:34:49 INFO - 'sessionrestore_no_auto_restore', 04:34:49 INFO - 'tabpaint']}, 04:34:49 INFO - 'other-e10s': {'tests': ['a11yr', 04:34:49 INFO - 'ts_paint', 04:34:49 INFO - 'tpaint', 04:34:49 INFO - 'sessionrestore', 04:34:49 INFO - 'sessionrestore_no_auto_restore', 04:34:49 INFO - 'tabpaint']}, 04:34:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:34:49 INFO - 'ts_paint', 04:34:49 INFO - 'tpaint', 04:34:49 INFO - 'sessionrestore', 04:34:49 INFO - 'sessionrestore_no_auto_restore', 04:34:49 INFO - 'tabpaint']}, 04:34:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:34:49 INFO - 'ts_paint', 04:34:49 INFO - 'tpaint', 04:34:49 INFO - 'sessionrestore', 04:34:49 INFO - 'sessionrestore_no_auto_restore', 04:34:49 INFO - 'tabpaint']}, 04:34:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:34:49 INFO - 'tests': ['a11yr', 04:34:49 INFO - 'ts_paint', 04:34:49 INFO - 'tpaint', 04:34:49 INFO - 'sessionrestore', 04:34:49 INFO - 'sessionrestore_no_auto_restore', 04:34:49 INFO - 'tabpaint']}, 04:34:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:34:49 INFO - 'tests': ['a11yr', 04:34:49 INFO - 'ts_paint', 04:34:49 INFO - 'tpaint', 04:34:49 INFO - 'sessionrestore', 04:34:49 INFO - 'sessionrestore_no_auto_restore', 04:34:49 INFO - 'tabpaint']}, 04:34:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:34:49 INFO - 'tests': ['tsvgx', 04:34:49 INFO - 'tsvgr_opacity', 04:34:49 INFO - 'tart', 04:34:49 INFO - 'tscrollx', 04:34:49 INFO - 'cart', 04:34:49 INFO - 'tsvg_static']}, 04:34:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:34:49 INFO - 'tsvgr_opacity', 04:34:49 INFO - 'tart', 04:34:49 INFO - 'tscrollx', 04:34:49 INFO - 'cart', 04:34:49 INFO - 'tsvg_static']}, 04:34:49 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:34:49 INFO - 'talos_options': ['--disable-e10s'], 04:34:49 INFO - 'tests': ['tp5o']}, 04:34:49 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:34:49 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:34:49 INFO - 'talos_options': ['--disable-e10s', 04:34:49 INFO - '--xperf_path', 04:34:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:34:49 INFO - 'tests': ['tp5n']}, 04:34:49 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:34:49 INFO - 'talos_options': ['--xperf_path', 04:34:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:34:49 INFO - 'tests': ['tp5n']}}, 04:34:49 INFO - 'talos.zip': {'path': '', 04:34:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:34:49 INFO - Running post-action listener: _resource_record_post_action 04:34:49 INFO - [mozharness: 2017-01-14 12:34:49.486411Z] Finished populate-webroot step (success) 04:34:49 INFO - [mozharness: 2017-01-14 12:34:49.486505Z] Running create-virtualenv step. 04:34:49 INFO - Running pre-action listener: _resource_record_pre_action 04:34:49 INFO - Running main action method: create_virtualenv 04:34:49 INFO - Creating virtualenv /builds/slave/test/build/venv 04:34:49 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:34:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:34:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:34:49 INFO - Using real prefix '/tools/python27' 04:34:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:34:50 INFO - Installing distribute.............................................................................................................................................................................................done. 04:34:53 INFO - Installing pip.................done. 04:34:53 INFO - Return code: 0 04:34:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:34:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:34:53 INFO - Reading from file tmpfile_stdout 04:34:53 INFO - Output received: 04:34:53 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:34:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:34:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:34:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:34:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100c40b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c43768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbf1cb8f10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a1ed30>, '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 0x100945db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a13be8>, '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.8phl2DXfk2/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.2oCsQKvJYP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/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:34:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:34:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:34:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8phl2DXfk2/Render', 04:34:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:34:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:34:53 INFO - 'HOME': '/Users/cltbld', 04:34:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:34:53 INFO - 'LOGNAME': 'cltbld', 04:34:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:53 INFO - 'MOZ_NO_REMOTE': '1', 04:34:53 INFO - 'NO_EM_RESTART': '1', 04:34:53 INFO - 'PAGER': '/bin/cat', 04:34:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:34:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:53 INFO - 'PWD': '/builds/slave/test', 04:34:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:34:53 INFO - 'SHELL': '/bin/bash', 04:34:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2oCsQKvJYP/Listeners', 04:34:53 INFO - 'TMPDIR': '/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/', 04:34:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:34:53 INFO - 'USER': 'cltbld', 04:34:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:34:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:34:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:53 INFO - 'XPC_FLAGS': '0x0', 04:34:53 INFO - 'XPC_SERVICE_NAME': '0', 04:34:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:34:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:53 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:34:53 INFO - Cleaning up... 04:34:53 INFO - Return code: 0 04:34:53 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:34:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:34:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:34:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x100c40b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c43768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbf1cb8f10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a1ed30>, '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 0x100945db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a13be8>, '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.8phl2DXfk2/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.2oCsQKvJYP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/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:34:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:34:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:34:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8phl2DXfk2/Render', 04:34:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:34:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:34:53 INFO - 'HOME': '/Users/cltbld', 04:34:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:34:53 INFO - 'LOGNAME': 'cltbld', 04:34:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:53 INFO - 'MOZ_NO_REMOTE': '1', 04:34:53 INFO - 'NO_EM_RESTART': '1', 04:34:53 INFO - 'PAGER': '/bin/cat', 04:34:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:34:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:53 INFO - 'PWD': '/builds/slave/test', 04:34:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:34:53 INFO - 'SHELL': '/bin/bash', 04:34:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2oCsQKvJYP/Listeners', 04:34:53 INFO - 'TMPDIR': '/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/', 04:34:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:34:53 INFO - 'USER': 'cltbld', 04:34:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:34:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:34:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:53 INFO - 'XPC_FLAGS': '0x0', 04:34:53 INFO - 'XPC_SERVICE_NAME': '0', 04:34:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:34:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:54 INFO - Downloading/unpacking psutil>=3.1.1 04:34:54 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:34:54 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:34:54 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:34:54 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:34:54 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:34:54 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:34:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:34:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:34:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:34:58 INFO - Installing collected packages: psutil 04:34:58 INFO - Running setup.py install for psutil 04:34:58 INFO - building 'psutil._psutil_osx' extension 04:34:58 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:34:58 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:34:59 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:34:59 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:34:59 INFO - building 'psutil._psutil_posix' extension 04:34:59 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:34:59 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:34:59 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:34:59 INFO - ^ 04:34:59 INFO - 1 warning generated. 04:34:59 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:34:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:34:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:34:59 INFO - Successfully installed psutil 04:34:59 INFO - Cleaning up... 04:34:59 INFO - Return code: 0 04:34:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:34:59 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:34:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:59 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:34:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:59 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 0x100c40b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c43768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbf1cb8f10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a1ed30>, '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 0x100945db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a13be8>, '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.8phl2DXfk2/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.2oCsQKvJYP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/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:34:59 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:34:59 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:34:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8phl2DXfk2/Render', 04:34:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:34:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:34:59 INFO - 'HOME': '/Users/cltbld', 04:34:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:34:59 INFO - 'LOGNAME': 'cltbld', 04:34:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:59 INFO - 'MOZ_NO_REMOTE': '1', 04:34:59 INFO - 'NO_EM_RESTART': '1', 04:34:59 INFO - 'PAGER': '/bin/cat', 04:34:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:34:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:59 INFO - 'PWD': '/builds/slave/test', 04:34:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:34:59 INFO - 'SHELL': '/bin/bash', 04:34:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2oCsQKvJYP/Listeners', 04:34:59 INFO - 'TMPDIR': '/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/', 04:34:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:34:59 INFO - 'USER': 'cltbld', 04:34:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:34:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:34:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:59 INFO - 'XPC_FLAGS': '0x0', 04:34:59 INFO - 'XPC_SERVICE_NAME': '0', 04:34:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:34:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:59 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:34:59 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:34:59 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:34:59 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:34:59 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:34:59 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:34:59 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:35:03 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:35:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:35:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:35:03 INFO - Installing collected packages: mozsystemmonitor 04:35:03 INFO - Running setup.py install for mozsystemmonitor 04:35:03 INFO - Successfully installed mozsystemmonitor 04:35:03 INFO - Cleaning up... 04:35:03 INFO - Return code: 0 04:35:03 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:35:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:35:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:35:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:35:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:35:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:03 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 0x100c40b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c43768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbf1cb8f10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a1ed30>, '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 0x100945db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a13be8>, '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.8phl2DXfk2/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.2oCsQKvJYP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/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:35:03 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:35:03 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:35:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8phl2DXfk2/Render', 04:35:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:35:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:35:03 INFO - 'HOME': '/Users/cltbld', 04:35:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:35:03 INFO - 'LOGNAME': 'cltbld', 04:35:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:35:03 INFO - 'MOZ_NO_REMOTE': '1', 04:35:03 INFO - 'NO_EM_RESTART': '1', 04:35:03 INFO - 'PAGER': '/bin/cat', 04:35:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:35:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:35:03 INFO - 'PWD': '/builds/slave/test', 04:35:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:35:03 INFO - 'SHELL': '/bin/bash', 04:35:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2oCsQKvJYP/Listeners', 04:35:03 INFO - 'TMPDIR': '/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/', 04:35:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:35:03 INFO - 'USER': 'cltbld', 04:35:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:35:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:35:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:35:03 INFO - 'XPC_FLAGS': '0x0', 04:35:03 INFO - 'XPC_SERVICE_NAME': '0', 04:35:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:35:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:35:03 INFO - Downloading/unpacking jsonschema==2.5.1 04:35:03 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:35:03 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:35:03 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:35:03 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:35:03 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:35:03 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:35:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:35:06 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:35:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:35:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:35:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:35:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:35:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:35:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:35:07 INFO - Downloading functools32-3.2.3-2.tar.gz 04:35:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:35:07 INFO - warning: no files found matching '*.txt' 04:35:07 INFO - no previously-included directories found matching 'build' 04:35:07 INFO - no previously-included directories found matching 'dist' 04:35:07 INFO - no previously-included directories found matching '.git*' 04:35:07 INFO - Installing collected packages: jsonschema, functools32 04:35:07 INFO - Running setup.py install for functools32 04:35:07 INFO - warning: no files found matching '*.txt' 04:35:07 INFO - no previously-included directories found matching 'build' 04:35:07 INFO - no previously-included directories found matching 'dist' 04:35:07 INFO - no previously-included directories found matching '.git*' 04:35:07 INFO - Successfully installed jsonschema functools32 04:35:07 INFO - Cleaning up... 04:35:07 INFO - Return code: 0 04:35:07 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:35:07 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:35:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:35:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:07 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:35:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:35:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:07 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 0x100c40b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c43768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbf1cb8f10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a1ed30>, '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 0x100945db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a13be8>, '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.8phl2DXfk2/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.2oCsQKvJYP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/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:35:07 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:35:07 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:35:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8phl2DXfk2/Render', 04:35:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:35:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:35:07 INFO - 'HOME': '/Users/cltbld', 04:35:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:35:07 INFO - 'LOGNAME': 'cltbld', 04:35:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:35:07 INFO - 'MOZ_NO_REMOTE': '1', 04:35:07 INFO - 'NO_EM_RESTART': '1', 04:35:07 INFO - 'PAGER': '/bin/cat', 04:35:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:35:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:35:07 INFO - 'PWD': '/builds/slave/test', 04:35:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:35:07 INFO - 'SHELL': '/bin/bash', 04:35:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2oCsQKvJYP/Listeners', 04:35:07 INFO - 'TMPDIR': '/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/', 04:35:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:35:07 INFO - 'USER': 'cltbld', 04:35:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:35:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:35:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:35:07 INFO - 'XPC_FLAGS': '0x0', 04:35:07 INFO - 'XPC_SERVICE_NAME': '0', 04:35:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:35:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:35:07 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:35:07 INFO - Cleaning up... 04:35:07 INFO - Return code: 0 04:35:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:35:07 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:35:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:35:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:07 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:35:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:35:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:07 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 0x100c40b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c43768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbf1cb8f10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a1ed30>, '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 0x100945db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a13be8>, '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.8phl2DXfk2/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.2oCsQKvJYP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/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:35:07 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:35:07 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:35:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8phl2DXfk2/Render', 04:35:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:35:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:35:07 INFO - 'HOME': '/Users/cltbld', 04:35:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:35:07 INFO - 'LOGNAME': 'cltbld', 04:35:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:35:07 INFO - 'MOZ_NO_REMOTE': '1', 04:35:07 INFO - 'NO_EM_RESTART': '1', 04:35:07 INFO - 'PAGER': '/bin/cat', 04:35:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:35:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:35:07 INFO - 'PWD': '/builds/slave/test', 04:35:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:35:07 INFO - 'SHELL': '/bin/bash', 04:35:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2oCsQKvJYP/Listeners', 04:35:07 INFO - 'TMPDIR': '/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/', 04:35:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:35:07 INFO - 'USER': 'cltbld', 04:35:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:35:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:35:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:35:07 INFO - 'XPC_FLAGS': '0x0', 04:35:07 INFO - 'XPC_SERVICE_NAME': '0', 04:35:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:35:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:35:08 INFO - Downloading/unpacking blobuploader==1.2.4 04:35:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:35:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:35:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:35:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:35:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:35:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:35:10 INFO - Downloading blobuploader-1.2.4.tar.gz 04:35:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:35:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:35:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:35:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:35:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:35:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:35:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:35:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:35:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:35:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:35:11 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:35:11 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:35:11 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:35:11 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:35:11 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:35:11 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:35:11 INFO - Downloading docopt-0.6.1.tar.gz 04:35:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:35:12 INFO - Installing collected packages: blobuploader, requests, docopt 04:35:12 INFO - Running setup.py install for blobuploader 04:35:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:35:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:35:12 INFO - Running setup.py install for requests 04:35:12 INFO - Running setup.py install for docopt 04:35:12 INFO - Successfully installed blobuploader requests docopt 04:35:12 INFO - Cleaning up... 04:35:12 INFO - Return code: 0 04:35:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:35:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:35:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:35:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:35:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:35:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:12 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 0x100c40b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c43768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbf1cb8f10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a1ed30>, '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 0x100945db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a13be8>, '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.8phl2DXfk2/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.2oCsQKvJYP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/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:35:12 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:35:12 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:35:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8phl2DXfk2/Render', 04:35:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:35:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:35:12 INFO - 'HOME': '/Users/cltbld', 04:35:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:35:12 INFO - 'LOGNAME': 'cltbld', 04:35:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:35:12 INFO - 'MOZ_NO_REMOTE': '1', 04:35:12 INFO - 'NO_EM_RESTART': '1', 04:35:12 INFO - 'PAGER': '/bin/cat', 04:35:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:35:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:35:12 INFO - 'PWD': '/builds/slave/test', 04:35:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:35:12 INFO - 'SHELL': '/bin/bash', 04:35:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2oCsQKvJYP/Listeners', 04:35:12 INFO - 'TMPDIR': '/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/', 04:35:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:35:12 INFO - 'USER': 'cltbld', 04:35:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:35:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:35:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:35:12 INFO - 'XPC_FLAGS': '0x0', 04:35:12 INFO - 'XPC_SERVICE_NAME': '0', 04:35:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:35:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:35:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:35:13 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-IVDSvC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:35:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:35:13 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-5AII2H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:35:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:35:13 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-WYCZay-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:35:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:35:13 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-ZWTCEf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:35:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:35:13 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-4OXXMO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:35:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:35:13 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-Nhp2mJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:35:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:35:13 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-k7WwvQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:35:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:35:13 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-sCehzk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:35:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:35:14 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-5bSwFB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:35:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:35:14 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-Wrhewa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:35:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:35:14 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-VbmIYD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:35:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:35:14 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-bSgYsT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:35:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:35:14 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-OYIEPN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:35:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:35:14 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-mnb2G4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:35:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:35:14 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-8y71R2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:35:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:35:14 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-tndc38-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:35:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:35:14 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-CEs4qP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:35:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:35:15 INFO - Running setup.py install for manifestparser 04:35:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:35:15 INFO - Running setup.py install for mozcrash 04:35:15 INFO - Running setup.py install for mozdebug 04:35:15 INFO - Running setup.py install for mozdevice 04:35:15 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:35:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:35:15 INFO - Running setup.py install for mozfile 04:35:15 INFO - Running setup.py install for mozhttpd 04:35:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:35:15 INFO - Running setup.py install for mozinfo 04:35:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:35:16 INFO - Running setup.py install for mozInstall 04:35:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:35:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:35:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:35:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:35:16 INFO - Running setup.py install for mozleak 04:35:16 INFO - Running setup.py install for mozlog 04:35:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:35:16 INFO - Running setup.py install for moznetwork 04:35:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:35:16 INFO - Running setup.py install for mozprocess 04:35:16 INFO - Running setup.py install for mozprofile 04:35:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:35:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:35:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:35:16 INFO - Running setup.py install for mozrunner 04:35:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:35:17 INFO - Running setup.py install for mozscreenshot 04:35:17 INFO - Running setup.py install for moztest 04:35:17 INFO - Running setup.py install for mozversion 04:35:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:35:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:35:17 INFO - Cleaning up... 04:35:17 INFO - Return code: 0 04:35:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:35:17 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:35:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:35:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:17 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:35:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:35:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:17 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 0x100c40b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c43768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbf1cb8f10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a1ed30>, '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 0x100945db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a13be8>, '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.8phl2DXfk2/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.2oCsQKvJYP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/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:35:17 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:35:17 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:35:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8phl2DXfk2/Render', 04:35:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:35:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:35:17 INFO - 'HOME': '/Users/cltbld', 04:35:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:35:17 INFO - 'LOGNAME': 'cltbld', 04:35:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:35:17 INFO - 'MOZ_NO_REMOTE': '1', 04:35:17 INFO - 'NO_EM_RESTART': '1', 04:35:17 INFO - 'PAGER': '/bin/cat', 04:35:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:35:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:35:17 INFO - 'PWD': '/builds/slave/test', 04:35:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:35:17 INFO - 'SHELL': '/bin/bash', 04:35:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2oCsQKvJYP/Listeners', 04:35:17 INFO - 'TMPDIR': '/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/', 04:35:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:35:17 INFO - 'USER': 'cltbld', 04:35:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:35:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:35:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:35:17 INFO - 'XPC_FLAGS': '0x0', 04:35:17 INFO - 'XPC_SERVICE_NAME': '0', 04:35:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:35:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:35:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:35:17 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-OOCnY2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:35:17 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:35:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:35:17 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-MNXq_w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:35:18 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:35:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:35:18 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-ZmT_qL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:35:18 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:35:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:35:18 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-w2QV3m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:35:18 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:35:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:35:18 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-eDpmkU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:35:18 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:35:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:35:18 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-n0F_a8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:35:18 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:35:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:35:18 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-0jmg5X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:35:18 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:35:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:35:18 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-vDue8m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:35:18 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:35:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:35:18 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-Jf95P8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:35:18 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:35:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:35:18 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-ttQnXR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:35:18 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:35:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:35:18 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-AbTu_Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:35:19 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:35:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:35:19 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-GDJg0t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:35:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:35:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:35:19 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-ASjyWz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:35:19 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:35:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:35:19 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-Ee8dj8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:35:19 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:35:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:35:19 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-ssCOVp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:35:19 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:35:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:35:19 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-3psKUA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:35:19 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:35:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:35:19 INFO - Running setup.py (path:/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/pip-poJzxZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:35:19 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:35:19 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:35:19 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:35:19 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:35:19 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:35:19 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:35:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:35:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:35:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:35:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:35:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:35:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:35:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:35:22 INFO - Downloading blessings-1.6.tar.gz 04:35:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:35:22 INFO - Installing collected packages: blessings 04:35:22 INFO - Running setup.py install for blessings 04:35:22 INFO - Successfully installed blessings 04:35:22 INFO - Cleaning up... 04:35:22 INFO - Return code: 0 04:35:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:35:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:35:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:35:22 INFO - Reading from file tmpfile_stdout 04:35:22 INFO - Current package versions: 04:35:22 INFO - blessings == 1.6 04:35:22 INFO - blobuploader == 1.2.4 04:35:22 INFO - docopt == 0.6.1 04:35:22 INFO - functools32 == 3.2.3-2 04:35:22 INFO - jsonschema == 2.5.1 04:35:22 INFO - manifestparser == 1.1 04:35:22 INFO - mozInstall == 1.12 04:35:22 INFO - mozcrash == 1.0 04:35:22 INFO - mozdebug == 0.1 04:35:22 INFO - mozdevice == 0.49 04:35:22 INFO - mozfile == 1.2 04:35:22 INFO - mozhttpd == 0.7 04:35:22 INFO - mozinfo == 0.9 04:35:22 INFO - mozleak == 0.1 04:35:22 INFO - mozlog == 3.4 04:35:22 INFO - moznetwork == 0.27 04:35:22 INFO - mozprocess == 0.24 04:35:22 INFO - mozprofile == 0.28 04:35:22 INFO - mozrunner == 6.13 04:35:22 INFO - mozscreenshot == 0.1 04:35:22 INFO - mozsystemmonitor == 0.3 04:35:22 INFO - moztest == 0.8 04:35:22 INFO - mozversion == 1.4 04:35:22 INFO - psutil == 3.1.1 04:35:22 INFO - requests == 1.2.3 04:35:22 INFO - wsgiref == 0.1.2 04:35:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:35:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:35:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:35:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:35:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:35:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:22 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 0x100c40b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c43768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbf1cb8f10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a1ed30>, '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 0x100945db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a13be8>, '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.8phl2DXfk2/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.2oCsQKvJYP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/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:35:22 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:35:22 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:35:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8phl2DXfk2/Render', 04:35:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:35:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:35:22 INFO - 'HOME': '/Users/cltbld', 04:35:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:35:22 INFO - 'LOGNAME': 'cltbld', 04:35:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:35:22 INFO - 'MOZ_NO_REMOTE': '1', 04:35:22 INFO - 'NO_EM_RESTART': '1', 04:35:22 INFO - 'PAGER': '/bin/cat', 04:35:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:35:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:35:22 INFO - 'PWD': '/builds/slave/test', 04:35:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:35:22 INFO - 'SHELL': '/bin/bash', 04:35:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2oCsQKvJYP/Listeners', 04:35:22 INFO - 'TMPDIR': '/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/', 04:35:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:35:22 INFO - 'USER': 'cltbld', 04:35:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:35:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:35:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:35:22 INFO - 'XPC_FLAGS': '0x0', 04:35:22 INFO - 'XPC_SERVICE_NAME': '0', 04:35:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:35:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:35:23 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:35:23 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:35:23 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:35:23 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:35:23 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:35:23 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:35:23 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:35:23 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:35:23 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:35:23 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:35:23 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:35:23 INFO - Cleaning up... 04:35:23 INFO - Return code: 0 04:35:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:35:23 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:35:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:35:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:23 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:35:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:35:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:23 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 0x100c40b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c43768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbf1cb8f10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a1ed30>, '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 0x100945db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a13be8>, '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.8phl2DXfk2/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.2oCsQKvJYP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/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:35:23 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:35:23 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:35:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8phl2DXfk2/Render', 04:35:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:35:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:35:23 INFO - 'HOME': '/Users/cltbld', 04:35:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:35:23 INFO - 'LOGNAME': 'cltbld', 04:35:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:35:23 INFO - 'MOZ_NO_REMOTE': '1', 04:35:23 INFO - 'NO_EM_RESTART': '1', 04:35:23 INFO - 'PAGER': '/bin/cat', 04:35:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:35:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:35:23 INFO - 'PWD': '/builds/slave/test', 04:35:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:35:23 INFO - 'SHELL': '/bin/bash', 04:35:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2oCsQKvJYP/Listeners', 04:35:23 INFO - 'TMPDIR': '/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/', 04:35:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:35:23 INFO - 'USER': 'cltbld', 04:35:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:35:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:35:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:35:23 INFO - 'XPC_FLAGS': '0x0', 04:35:23 INFO - 'XPC_SERVICE_NAME': '0', 04:35:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:35:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:35:23 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:35:23 INFO - Cleaning up... 04:35:23 INFO - Return code: 0 04:35:23 INFO - Running post-action listener: _resource_record_post_action 04:35:23 INFO - Running post-action listener: _start_resource_monitoring 04:35:23 INFO - Starting resource monitoring. 04:35:23 INFO - [mozharness: 2017-01-14 12:35:23.542947Z] Finished create-virtualenv step (success) 04:35:23 INFO - [mozharness: 2017-01-14 12:35:23.544003Z] Running install step. 04:35:23 INFO - Running pre-action listener: _resource_record_pre_action 04:35:23 INFO - Running main action method: install 04:35:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:35:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:35:23 INFO - Reading from file tmpfile_stdout 04:35:23 INFO - Detecting whether we're running mozinstall >=1.0... 04:35:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:35:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:35:23 INFO - Reading from file tmpfile_stdout 04:35:23 INFO - Output received: 04:35:23 INFO - Usage: mozinstall [options] installer 04:35:23 INFO - Options: 04:35:23 INFO - -h, --help show this help message and exit 04:35:23 INFO - -d DEST, --destination=DEST 04:35:23 INFO - Directory to install application into. [default: 04:35:23 INFO - "/builds/slave/test"] 04:35:23 INFO - --app=APP Application being installed. [default: firefox] 04:35:23 INFO - mkdir: /builds/slave/test/build/application 04:35:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:35:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:35:45 INFO - Reading from file tmpfile_stdout 04:35:45 INFO - Output received: 04:35:45 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 04:35:45 INFO - Running post-action listener: _resource_record_post_action 04:35:45 INFO - [mozharness: 2017-01-14 12:35:45.561116Z] Finished install step (success) 04:35:45 INFO - [mozharness: 2017-01-14 12:35:45.561307Z] Running run-tests step. 04:35:45 INFO - Running pre-action listener: _resource_record_pre_action 04:35:45 INFO - Running main action method: run_tests 04:35:45 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:35:45 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:35:45 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:35:45 INFO - 2017-01-14 04:35:45.575 screenresolution[1992:13637] starting screenresolution argv=screenresolution get 04:35:45 INFO - 2017-01-14 04:35:45.578 screenresolution[1992:13637] Display 0: 1600x1200x32@60 04:35:45 INFO - 2017-01-14 04:35:45.584 screenresolution[1993:13640] starting screenresolution argv=screenresolution list 04:35:45 INFO - Available Modes on Display 0 04:35:45 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:35:45 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:35:45 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:35:45 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:35:45 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:35:45 INFO - Intel Iris: 04:35:45 INFO - Chipset Model: Intel Iris 04:35:45 INFO - Type: GPU 04:35:45 INFO - Bus: Built-In 04:35:45 INFO - VRAM (Dynamic, Max): 1536 MB 04:35:45 INFO - Vendor: Intel (0x8086) 04:35:45 INFO - Device ID: 0x0a2e 04:35:45 INFO - Revision ID: 0x0009 04:35:45 INFO - Displays: 04:35:45 INFO - Display: 04:35:45 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:35:45 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:35:45 INFO - Display Serial Number: 1600x1200 60 04:35:45 INFO - Main Display: Yes 04:35:45 INFO - Mirror: Off 04:35:45 INFO - Online: Yes 04:35:45 INFO - Rotation: Supported 04:35:45 INFO - Return code: 0 04:35:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:35:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:35:45 INFO - Python 2.7.3 04:35:45 INFO - Return code: 0 04:35:45 INFO - grabbing minidump binary from tooltool 04:35:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:35:45 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 0x100a1ed30>, '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 0x100945db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a13be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:35:45 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:35:45 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:35:45 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:35:45 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:35:45 INFO - Return code: 0 04:35:45 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:35:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:35:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:35:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:35:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:35:45 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/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LhNaBhW-T7-leuif4HywFg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0175', '--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:35:45 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/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LhNaBhW-T7-leuif4HywFg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0175 --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:35:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8phl2DXfk2/Render', 04:35:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:35:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:35:45 INFO - 'HOME': '/Users/cltbld', 04:35:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:35:45 INFO - 'LOGNAME': 'cltbld', 04:35:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:35:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:35:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:35:45 INFO - 'MOZ_NO_REMOTE': '1', 04:35:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:35:45 INFO - 'NO_EM_RESTART': '1', 04:35:45 INFO - 'PAGER': '/bin/cat', 04:35:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:35:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:35:45 INFO - 'PWD': '/builds/slave/test', 04:35:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:35:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:35:45 INFO - 'SHELL': '/bin/bash', 04:35:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2oCsQKvJYP/Listeners', 04:35:45 INFO - 'TMPDIR': '/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/', 04:35:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:35:45 INFO - 'USER': 'cltbld', 04:35:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:35:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:35:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:35:45 INFO - 'XPC_FLAGS': '0x0', 04:35:45 INFO - 'XPC_SERVICE_NAME': '0', 04:35:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:35:45 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/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LhNaBhW-T7-leuif4HywFg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0175', '--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:35:46 INFO - mozversion application_buildid: 20170114030206 04:35:46 INFO - mozversion application_changeset: ac3275723df59db0f09198fdb61b51e7002c391a 04:35:46 INFO - mozversion application_display_name: Nightly 04:35:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:35:46 INFO - mozversion application_name: Firefox 04:35:46 INFO - mozversion application_remotingname: firefox 04:35:46 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:35:46 INFO - mozversion application_vendor: Mozilla 04:35:46 INFO - mozversion application_version: 53.0a1 04:35:46 INFO - mozversion platform_buildid: 20170114030206 04:35:46 INFO - mozversion platform_changeset: ac3275723df59db0f09198fdb61b51e7002c391a 04:35:46 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:35:46 INFO - mozversion platform_version: 53.0a1 04:35:46 INFO - using testdate: 1484397346 04:35:46 INFO - actual date: 1484397346 04:35:46 INFO - starting webserver on 'localhost:49335' 04:35:46 INFO - SUITE-START | Running 2 tests 04:35:46 INFO - TEST-START | dromaeo_css 04:35:46 INFO - operating with platform_type : mac_ 04:35:46 INFO - Initialising browser for dromaeo_css test... 04:35:46 INFO - TEST-INFO | started process 2003 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/tmpbk8DdQ/profile http://localhost:49335/getInfo.html) 04:35:48 INFO - PROCESS | 2003 | __metrics Screen width/height:1600/1200 04:35:48 INFO - PROCESS | 2003 | colorDepth:24 04:35:48 INFO - PROCESS | 2003 | Browser inner width/height: 1024/689 04:35:48 INFO - PROCESS | 2003 | __metrics 04:35:48 INFO - PROCESS | 2003 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:35:48 INFO - PROCESS | 2003 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:35:49 INFO - TEST-INFO | 2003: exit 0 04:35:49 INFO - Browser initialized. 04:35:49 INFO - Running cycle 1/1 for dromaeo_css test... 04:35:49 INFO - TEST-INFO | started process 2005 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/tmpbk8DdQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:36:01 INFO - PROCESS | 2005 | RSS: Main: 226639872 04:36:01 INFO - PROCESS | 2005 | 04:39:06 INFO - PROCESS | 2005 | Cycle 1(1): loaded http://localhost:49335/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49335/tests/dromaeo/cssquery-ext.html) 04:39:07 INFO - PROCESS | 2005 | RSS: Main: 340549632 04:39:07 INFO - PROCESS | 2005 | 04:40:51 INFO - PROCESS | 2005 | ************************* 04:40:51 INFO - PROCESS | 2005 | A coding exception was thrown and uncaught in a Task. 04:40:51 INFO - PROCESS | 2005 | 04:40:51 ERROR - PROCESS | 2005 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:40:51 INFO - PROCESS | 2005 | Full stack: 04:40:51 INFO - PROCESS | 2005 | ************************* 04:42:10 INFO - PROCESS | 2005 | Cycle 1(1): loaded http://localhost:49335/tests/dromaeo/cssquery-ext.html (next: http://localhost:49335/tests/dromaeo/cssquery-jquery.html) 04:42:11 INFO - PROCESS | 2005 | RSS: Main: 375128064 04:42:11 INFO - PROCESS | 2005 | 04:45:13 INFO - PROCESS | 2005 | Cycle 1(1): loaded http://localhost:49335/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49335/tests/dromaeo/cssquery-mootools.html) 04:45:14 INFO - PROCESS | 2005 | RSS: Main: 326496256 04:45:14 INFO - PROCESS | 2005 | 04:48:16 INFO - PROCESS | 2005 | Cycle 1(1): loaded http://localhost:49335/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49335/tests/dromaeo/cssquery-prototype.html) 04:48:17 INFO - PROCESS | 2005 | RSS: Main: 327331840 04:48:17 INFO - PROCESS | 2005 | 04:51:20 INFO - PROCESS | 2005 | Cycle 1(1): loaded http://localhost:49335/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49335/tests/dromaeo/cssquery-yui.html) 04:51:21 INFO - PROCESS | 2005 | RSS: Main: 326164480 04:51:21 INFO - PROCESS | 2005 | 04:54:24 INFO - PROCESS | 2005 | Cycle 1(1): loaded http://localhost:49335/tests/dromaeo/cssquery-yui.html (next: http://localhost:49335/tests/dromaeo/cssquery-dojo.html) 04:54:24 INFO - PROCESS | 2005 | RSS: Main: 376389632 04:54:24 INFO - PROCESS | 2005 | 04:54:24 INFO - PROCESS | 2005 | __start_tp_report 04:54:24 INFO - PROCESS | 2005 | _x_x_mozilla_page_load 04:54:24 INFO - PROCESS | 2005 | _x_x_mozilla_page_load_details 04:54:24 INFO - PROCESS | 2005 | |i|pagename|runs| 04:54:24 INFO - PROCESS | 2005 | |0;dojo.html;3227.8708851645933;3285.3265080658484;3289.999999999999;3329.417351963406;3356.7985920844735;5548.77804887804;5579.079451890439;5609.158626206061;5630.943690563098;5669.914951275734;5622.353429355615;5665.036943719567;5674.886502269963;5675.886482270352;5693.146028095788;5144.43411224765;5181.0674078665825;5188.533032027117;5222.529972302492;5254.185601231815;5272.604554658396;5275.6043296752705;5277.577793776489;5280.841574752763;5282.894342113155;5267.130923397634;5280.551153151987;5282.973585132069;5285.048691235576;5286.101362768339;5281.841544753625;5287.339082614654;5287.4976877196605;5288.153895376721;5292.126799078147;4932.753362331869;5176.482351764831;5233.450487698813;5237.109691352479;5239.947600523984;5648.350439699446;5699.002674531982;5762.07806750922;5768.163616275659;5777.277840269966;6109.908351374733;6185.319614842364;6254.0931564923285;6258.34287399821;6302.873942521124;6161.19904412428;6173.074038894157;6231.87536249277;6232.719527621268;6235;5832.8541786454825;5833.212516310328;5835.824925252249;5843.474087332075;5876.529877609823;6299.590526615755;6304.684765761694;6335.68321583919;6336.6831658416895;6339.936600634027;5936.5844390892225;5983.521318294526;5991.7902873399225;6077.3314935357075;6174.567780255429;6181.690915454209;6248;6265.8746825063245;6270.592411493239;6274.9686251569365;6114.2357205349335;6213.689315534205;6220.34686357935;6226.1905952225925;6264.123022776815;6105.247473116927;6133.059244993061;6246.968765156145;6260;6266.905996410058;4955.306257124005;4987.750612469435;5003.824866129741;5005.3242812220615;5032.446430892599;4472.709273897186;4490.7754612269255;4497.8425755098415;4502.279635258343;4520.299353600197;5614.887702246014;5722.256106706185;5736.368999410061;5745.683987380734;5788;5139.357580302462;6112.716259964451;6224;6230.127782110508;6255.593386429868;5695.829125126253;5725.026745453283;5738.856528586819;5749.965006298823;5775.913361299584;5333.57331413486;5394.757235924314;5395.676259424447;5423.2136340230445;5449.455054494519;6235.781747638993;6236.095766113888;6255.374462553799;6270.7805226816845;6309.842253943688;5019.7239151847;6168.537359698131;6183.938160618336;6195.535334849814;6291.245050593775;5160.561352285098;6256.874862502816;6289.993601023814;6305.6216627000695;6312.116303717391;6218.098375735583;6226.377362263737;6230.15892854477;6230.875382492415;6241.843953901189;6136.6011209271255;6140.565599444434;6268.435840774352;6284.402981716729;6315.526335524946;6089.847753806191;6126.448619624255;6144.324124346408;6166.938330616636;6173.59871608344;6108.905670139014;6112.326841499263;6112.541559383153;6135.171751813448;6146.770645870754;5787.276590426197;5925.05199168131;5959.046552551571;5983.850403739942;5988.850278743066;4976.701397916137;5970.97014514942;5983.880322393441;6010.278766548042;6124.356942520971;5826.126081087871;5881.353051164283;5906.26171728534;5910.911336329872;5925.140854576149 04:54:24 INFO - PROCESS | 2005 | |1;ext.html;441.0363356066992;453.18653017832986;493.65197535737303;500.5695102212099;519.2237604780853;28497.85751071244;32197.67802321979;41867;43514.782426087906;43531.56468435315;42527.57472425275;44858.77570612142;44955;44955.10089798202;44986.775066124705;9314.67398641046;9517.14415688941;9529.952350238274;9531.952340238324;9541;8566.571671416435;8788.956055219714;9412.058794120601;11330.943345283304;11646.475908584134;11529.365884876328;11596.826047609293;11611.129165312594;11616.767664646703;11622.07023438123;8573.356998225096;11538.942305288461;11594.304341739522;11624;11626.767464650744;8543.14568543147;11098.389588572625;11347.375894325809;11409.60066397672;11616.128790340757;41921;42388.94027649303;42402.57597424048;42420.93947651303;42478.362824557655;4029.2875976294836;4032.717709760318;4061.2892743770017;4086.4483294755123;4121.773302468363;31034.379312413625;31687;31714.841425792954;31748.888788892276;31819.840900795578;3050.801697889652;3074.13924101252;3085.490894002487;3174.349258402022;3221.983890080558;370615;370671;371179.1441042778;371295;371349.9999999973;60964;62906.370936290965;63357.04964425537;63433.36566634367;63531.094067178055;63820;66292;66393.6680316605;66485.00272495917;66679.66660166669;15721.528354149164;16153.273102710406;16173.595660108356;16183.514494565183;16195.919020405057;11220.719482013015;11270.943645281885;12441.688957776129;12493.063020273516;12594.496220151092;15182.46861359847;15643.765343519857;17129.657406852042;17257.309707611807;17583;7008.684609192598;7084.716611335489;7127.4654400920135;7167.964160179165;7185.389241914496;875.4353442029856;881.3389957531851;889.226373055446;906.1301150895083;923.584387025841;28872;30533.95772937865;30548.38903221923;30921.381572368427;31480.842595786875;1036.6993571864075;1040.8594839696543;1057.9947100264603;1076.9084627806567;1219.7802197802198;14371.568852934428;15661.608459788597;15869.285882135331;15908.886377953431;16453.58866028359;614045;618047;618976;619762;620686.8965655233;62687;62811;62953.68523157446;62997.37002629915;63176;1410.4710733474947;1457.2859298943442;1468.12646475347;1471.8454562271022;1474.9115053096848;26539.601905971813;28808;30124.54813177848;30651.693483065777;30726.385472290876;51707;52253.73873130762;52270.47729522656;52295.73852130715;52302.476975231286;448989;451729;451794;452055;453803;22554.985025674214;23769.286921392384;24436.389090272885;24512.387190320384;41842.58157418387;35424.46863297001;36881.44677829889;42119.57880421279;44475.33287000633;45023.87440314018;36896.81551592225;37274.813625931696;37552;38138.80930595329;38490.422643660924;36429.27141457103;36553.268934621694;37272.81363593165;37887.81056094702;38060.80969595134;36350.63649363472;37097.443538347485;38086.23827523489;38468.807655961544;38560;29099.272518187216;30449.391012180076;31366.843165784026;31399;32080.51879221767;23635.527289454458;24520.509589808462;24548.754512454645;24831.379215519755;24912 04:54:24 INFO - PROCESS | 2005 | |2;jquery.html;396.25701809107903;398.4262661767055;402.80262671291075;403.90710136668565;425.4426701021662;20534.486637834063;21260.255891043817;21449;21722.674159887614;21834.45413864652;21735.565288694215;21770.346889593337;21842.798646074458;22330.55338893221;22598.548029039408;5634.802781902645;5909.438603332676;5969.641821490724;5969.731362088716;5976.731047102869;5660.801871934483;5826.126081087828;5832.854178645546;5919.970400147993;5947.672877991708;5718.142278658213;5841.299044114712;5851.473367396933;5867.8533036674;5872.7063646817705;5610.410906854762;5762;5828.708564571797;5835;5839.124131380306;5128.666636668605;5145.691258524501;5164.793408263665;5166.844994650167;5167;27060.323491912663;27248.727512724818;27349.316267093283;27413.86293068522;27659.170224893085;2759.089500464842;2780.78800592545;2782.5130602144545;2791.204506715597;2878;15084.472043478536;15286.464973725866;16150.434734784227;16506.83493165077;16804.74792878108;1779.9555011124696;1832.9175187116612;1841.8618603604784;1843.8985855777926;1886.2643569008098;115032;119190;145357;154103.22948385298;174542;18486.907565462086;18523.785998373147;22310.442238944157;22804.88597557035;22815.31554053381;34170.487442688376;35014.9495515135;35198;37621.81189094037;41290.38064429036;10909.454527273763;11018.834717479243;11366.943165284121;11375.772484550263;11596.652100437;9048.728538143867;9050.27597792175;9065.68270110543;9228.723138305862;9235.953820230856;9131.360804743737;10450.477476126163;10706.036456718934;10822.288571100964;10921.945390273157;3465.7920524768597;4021.577734337911;4118.814653340607;4130.752154870717;4131.938020929689;875.5534677314615;1002.8445590933271;1019.6023550815188;1040.4225654761528;1070.6092276319087;22077.116915323528;22305.99623016968;22640.660390094163;22736.863156842093;22803.657945130835;915.6520522201521;1021.897810218987;1026.5021464589668;1049.8687664041995;1078.2290662176424;11228.550857965753;11521.308721476738;11587.768244635061;11636.12729045325;11657.591984280509;705659.4151087737;722928;729913;749917;752887;124704;140777;150050.4944456109;161452;164604;1041.4480325427535;1065.9946700266448;1088;1093.4423444043596;1093.4423444043596;15948.920255398649;19808.504787379854;20899.791002089783;20930.744155350727;21127.788722113197;40526.1894762109;56229.59426014382;57093.14360284682;58211.12683309669;63412.68293658502;90111.09888901027;90336.548317258;90420;91192.54403728204;91843;8138;8391.244787969112;8640.308775298086;8848.513331766815;8849.292056635324;11813;12878.162919410208;13338.06633535682;13395.933020334836;13884.444622214998;11345.829812552653;11366.261193022758;11643.708907277385;11658.76682466363;11799.05607551411;9317.673881414388;10984.450777461256;11582.594609188975;11872;11983.940080299542;9138.223251023737;10654.094401975919;11593.6521904343;11974.401279936143;12052.397380131133;7706.422018348534;8401.53791541471;8403.075661677089;8678.739637810875;8903.821923561622;9604.807903841744;9868.802623947337;11315.264507806965;11428.314301141958;11459.541618335506 04:54:24 INFO - PROCESS | 2005 | |3;mootools.html;1442.5023366938403;1461.1452300404262;1482.2588705647177;1488.5534339698088;1499.505163296112;8065.193480651939;8495.872561911561;8502.107278735737;8503.532305723184;8512.063672995966;7403.777886663395;7676.232376762321;7689.961550192241;8092.39307051972;8341.165883411655;2295.9770402296012;2335.7664233576593;2336.2407217654245;2337.883105844701;2341.356127065054;2326.7789559991775;2354.0819080558595;2355.1639168095335;2362.4093976505874;2363.420961864346;2314.4098254944965;2315.583195024895;2332.7433982261937;2335.754745751697;2341.239097293378;2264.094362255103;2283.2807665585287;2288.2791920544973;2303.285981345788;2304.101400453824;2263.2644390572964;2326.5579539887535;2331.5336932613545;2336.7896889280046;2337.018452250059;8473.661053557851;8553.486790792573;8572.61423235956;8572.828543429096;8589.656413743443;5019.84940451787;5179.326687530634;5184.948150518484;5187.066328060948;5188.584913206934;3207.4226639204935;3318.7050253409616;3422.6064002639764;3464.34177506273;3475.33968545978;1129.3675541696593;1146.2663895107055;1191.332853601977;1203.3862730007759;1212.1514939542355;10896.564137434492;10988.725281868017;10996.23026388153;11009.449527523591;11034.117270618251;3410.7271418286477;4634.21218392874;4703.811847526061;4730.810767569327;4733;9503.66737164196;9509.476978766095;9513.476758778334;9515.666951656658;9537;5250;5252.868678282997;5253.23828044939;5254.65844720092;5256.684598924076;4283.914321713548;4435.246008178618;4501.729896206238;4712.151812673683;4776.570108690165;3756.887293381203;3802.676772474371;3862.942055869164;3896.493455850721;3906.277338692351;1134.597217987619;1218.8781121887741;1264.72808346206;1271.3643178410794;1285.2288626824018;779.8713212320017;851.089334412173;892.3619611977467;894.7584152278979;925.8703781470599;5335.33308336458;5363.785448582091;5560.972195139079;5752.108423194411;5786.855328616734;962.7544976031068;990.5146478225762;1003.2174903575223;1013.8428543575758;1030.07808011829;3564.7326450516316;3579.51676523666;3745.5879853216125;3757.3612485877466;3809.219269932909;9829.45937973404;10148.644797432054;10166.034226748447;10183.236257280734;10212.183025357954;9347.158755711882;9803.117719405287;9824.4105353679;10100.646477373404;10129.544170512345;7613.439244954771;7820.7262745804765;7833.255840695125;7842.52944823301;7851.254130857559;4819.59033482158;5363.766333743183;5695.772169113189;5727.997600419826;5825.184474173704;8968;9152.313576481658;9245.075492450702;9290.58192381331;9426.717198484057;9316.720498385059;9408.717738467856;9577.377470464398;9612.279079069238;9622.855657165008;7047.647617619201;7177.066981292399;7222.3860971817985;7312.634368281671;7351.595662238628;8012.158723333966;8101.35189184852;8106.39202059836;8112;8136.7152149674475;7099.148102227766;7172.462065345016;7219.350258476762;7317.341439270491;7323.231060738546;6962.582245065312;6974.407175390149;7019.403350715246;7073.363397294268;7223.097112860893;6325.905111423424;6435.227772667123;6442.645654489048;6456.548041637228;6460.095586617971;4940.851774446773;4974.552290293891;5019.121653710659;5032.7483625819295;5078.6444948854705;4928.137575924271;5033.597312214941;5038.874028149179;5091.592672586258;5180.792768289226 04:54:24 INFO - PROCESS | 2005 | |4;prototype.html;340.66784884737376;343.56561356337295;360.3046120986495;384.1337783298661;384.59041121205894;4060.776657283848;4755.90488190236;4990.725510096943;5463.699496527689;5511.862203444916;4890.7554622268835;5157.406898206707;5161.535461808446;5279.577633789298;5307.319803499237;3302.966970330302;4185.3378293992755;4193.329067349209;4198.874033778976;4230.661547076242;3384.3400536895315;3747.7563958342757;4013.5384430790396;4220.873373798776;4230.661547076242;3937.7243592948507;4014.6386825185728;4050.058928107704;4057.1885622875543;4060.2285565742413;3962.762234265939;4011.29802284599;4020.1758639478835;4038.4144299076615;4039.97980010101;3488.4767284907466;3496.248306614065;3500.9824950875336;3513.578370595519;3519.6128425873135;4702.6002789762915;4926.531979461945;5076.137188158929;5203;5241.397239317451;4569.058150286115;4571.451425828922;4613.261878099522;4616.030633566955;4618.284165954283;4449.777511124431;5074.746262686851;5079.85703216777;5523.232565579016;5572.247746554204;2942.7792915531422;3747.906302342436;3787.9431808522895;3834.348160812641;3837.4052021936363;4722.716637001791;5660.688662123582;5769.336526299488;5881.794137205177;5898.439648233411;3901.51231096113;3901.6293452122004;3901.6878649707955;3902.746321489094;3922.5489068756888;3823.2926908522013;3914.6868250539887;3952.960470395317;3953.5651078381356;3959.940600890989;4019.698522610816;4032.697547683935;4179.895502612399;4426.845060422934;4547.295169248771;5429.728513574306;5517.496389792511;5587.972060139673;5656.745446454919;5708.771649133988;1224.8591411987736;1249.5938819883575;1255.9010865492694;1264.5068423314915;1376.7040086381476;836.0144656440953;855.9957200213959;983.2772911909741;984.104464936904;998.5306905754284;4500.797464114123;4564.931526027112;4852.781624826891;4913.901721965541;5064.924026139611;4599.6090332321455;5492.780288788484;5510.090835012178;5568.860778480571;5617.157426385993;3899.493065901415;4319.719218250803;4944.060628480577;4948.911239527299;5063.8987220255385;2727.359070618403;2826.8409951919616;2856.7428931396275;2863.7519547155384;2907.4039821836895;4785.0952773407535;4839.903201936012;5241.947580524146;5691.373948865621;5702.087665973424;4724.960508688083;4923.4644158258525;5434.83695489136;5638.154276858422;5665.943340566541;5475.698836563947;5674.744636491368;5677.905541479903;5691.4877661010705;5725.398833122462;4250.512320687858;5504.22940788282;5745.511631511368;5828.70856457167;5867.559933005127;4932.753362331798;5518.1857252800555;5781.161731548986;5811.215485909348;5811.455012442322;5787.774924305197;6009.95661475083;6020.8795824084145;6026.849328766816;6051.243594550681;3848.4804551385205;3904.726669133247;3911.1395492991496;3916.1971795782365;3924.9402661280724;5768.769249230152;5777.306723193244;5807.419258074159;5808.419158084158;5820.417958204315;4922.630802689741;5171.586273098218;5625.521830644441;5655.971720141373;5659.575531835047;5181.409295352324;5248.9737551312;5657.85855353603;5666.688332141772;5669.829905102853;4708.717476951394;5271.578273738015;5298.483220470246;5330.466953304794;5450.972745136249;5599;5617.691026993554;5618.775248990158;5625.131183096569;5645.1532270159805;5285.462977770769;5448.746788238648;5476.891396812176;5487.917681234705;5530.087535556749 04:54:24 INFO - PROCESS | 2005 | |5;yui.html;721.1490441279288;725.1262229014038;765.058977457727;801.8476489467001;831.256025856858;14708.191049492274;15606.45377411788;15607.375704971788;15610.375584976615;15676.92161539192;14011.649708757286;14171.574852754407;14449.927750361234;14526.854731452682;14695.118292902433;851.3529717414763;860.9311255099577;876.4040452492303;878.1920633017639;878.9428687135315;682.740558587736;703.4969996452536;705.9576425414491;873.3449912565576;877.3902138014083;881.3918396306528;886.2422628652506;913.5614904845678;920.9915142918494;924.6070420071476;869.0353707384797;870.634333579898;871.289898732531;889.2663552569092;911.9772005699845;527.4303751947887;673.7877568565887;674.3324109131974;680.5610381304081;682.8804959132132;12463.12758106933;13220.942324614009;13582.320883955861;14893.73403260724;15201.771973420407;14368.928155359261;14444.638884027983;14488.492902748354;14577.854221457756;14632.780508292384;11898.10764192689;11909.702257443547;12034.939825300817;12085.879141208563;12189.634310970685;3346.4311067118406;3391.4573668213216;3476.235228249781;3486.581610206766;3505.3690335739557;91091.99999999933;107022;107539;109955.90044099536;110009;9594.05905958432;11078;11592.188546801643;12015.579454719043;12113.818292725617;23041.53916921652;23382;23633.645495317585;23678.763212368;23700.525989480113;7848.450608457468;7871.881921771178;8045.115037345888;8045.15525869787;8114.918850811534;4235.449391579075;4299.97850010748;4301.204277208726;4311.1808756336195;4316.892077698083;3493.4410494320787;3562.4834399011997;3631.3100510902846;3662.121090938209;3665.9266814663556;568.3520786303617;658.9934100658932;663.9502037347219;669.9095622091053;670.6847781542765;670.9899351509731;677.9694913728894;692.4597179638268;713.9785806425815;727.6434547071897;9150.22223111043;9272.72181834546;9819.656312029045;10427.530761115768;10429.9478502607;565.9688717120515;567.5970061256554;615.3446579392933;660.7918505670698;714.1430283659629;3905.6680182184264;4878.926816097762;4988.950110498921;4989.501049895054;5133.589312854962;99024.50487747515;101370;103618;104395;106223.46888265664;83545.58227208946;83616;85332;87042.56478717693;87093;79035.60482197552;79222.6038869802;79838.20161798423;79848.20151798523;80689.59655201803;9435.952820235854;9785.902140978498;9805.558749856416;9808.623173595128;9881.851772223567;40874.18251634891;47343.52656473391;48488.757556212;49056;50387;65223.67388163029;66025.66987165033;67429.66285168543;68393.65803170952;69183.65408173128;10864.348139111678;11151.16366272549;11928;12217.389130543615;12309;12886.67783305425;13163.802542962056;13260.933695331461;13584.388702508213;13730.244836534086;12611.747765044463;13289;13547.86452135466;13692.110012849133;14125.293735313398;13860.4455821766;14055.94580406494;14088;14244.572662820132;14662.340194691478;13484.533208550247;13554.59336219915;13619.387127579084;13799.79300310476;14061.2266325349;11338.546458141913;11379.146564007899;11535.423228838692;12044.096692747904;12074.577389791315;10995.334525510561;11027.431147270578;11454.370009649216;11610.535578576762;11621.24461909973 04:54:24 INFO - PROCESS | 2005 | __end_tp_report 04:54:24 INFO - PROCESS | 2005 | __start_cc_report 04:54:24 INFO - PROCESS | 2005 | _x_x_mozilla_cycle_collect,1573 04:54:24 INFO - PROCESS | 2005 | __end_cc_report 04:54:24 INFO - PROCESS | 2005 | __startTimestamp1484398464980__endTimestamp 04:54:24 INFO - PROCESS | 2005 | 04:54:24 INFO - PROCESS | 2005 | ------- Summary: start ------- 04:54:24 INFO - PROCESS | 2005 | Number of tests: 6 04:54:24 INFO - PROCESS | 2005 | 04:54:24 INFO - PROCESS | 2005 | [#0] dojo.html Cycles:165 Average:5721.05 Median:5906.26 stddev:635.03 (10.8%) stddev-sans-first:606.11 04:54:24 INFO - PROCESS | 2005 | Values: 3227.9 3285.3 3290.0 3329.4 3356.8 5548.8 5579.1 5609.2 5630.9 5669.9 5622.4 5665.0 5674.9 5675.9 5693.1 5144.4 5181.1 5188.5 5222.5 5254.2 5272.6 5275.6 5277.6 5280.8 5282.9 5267.1 5280.6 5283.0 5285.0 5286.1 5281.8 5287.3 5287.5 5288.2 5292.1 4932.8 5176.5 5233.5 5237.1 5239.9 5648.4 5699.0 5762.1 5768.2 5777.3 6109.9 6185.3 6254.1 6258.3 6302.9 6161.2 6173.1 6231.9 6232.7 6235.0 5832.9 5833.2 5835.8 5843.5 5876.5 6299.6 6304.7 6335.7 6336.7 6339.9 5936.6 5983.5 5991.8 6077.3 6174.6 6181.7 6248.0 6265.9 6270.6 6275.0 6114.2 6213.7 6220.3 6226.2 6264.1 6105.2 6133.1 6247.0 6260.0 6266.9 4955.3 4987.8 5003.8 5005.3 5032.4 4472.7 4490.8 4497.8 4502.3 4520.3 5614.9 5722.3 5736.4 5745.7 5788.0 5139.4 6112.7 6224.0 6230.1 6255.6 5695.8 5725.0 5738.9 5750.0 5775.9 5333.6 5394.8 5395.7 5423.2 5449.5 6235.8 6236.1 6255.4 6270.8 6309.8 5019.7 6168.5 6183.9 6195.5 6291.2 5160.6 6256.9 6290.0 6305.6 6312.1 6218.1 6226.4 6230.2 6230.9 6241.8 6136.6 6140.6 6268.4 6284.4 6315.5 6089.8 6126.4 6144.3 6166.9 6173.6 6108.9 6112.3 6112.5 6135.2 6146.8 5787.3 5925.1 5959.0 5983.9 5988.9 4976.7 5971.0 5983.9 6010.3 6124.4 5826.1 5881.4 5906.3 5910.9 5925.1 04:54:24 INFO - PROCESS | 2005 | 04:54:24 INFO - PROCESS | 2005 | [#1] ext.html Cycles:180 Average:63015.45 Median:371237.07 stddev:130948.00 (35.3%) stddev-sans-first:131231.07 04:54:24 INFO - PROCESS | 2005 | Values: 441.0 453.2 493.7 500.6 519.2 28497.9 32197.7 41867.0 43514.8 43531.6 42527.6 44858.8 44955.0 44955.1 44986.8 9314.7 9517.1 9530.0 9532.0 9541.0 8566.6 8789.0 9412.1 11330.9 11646.5 11529.4 11596.8 11611.1 11616.8 11622.1 8573.4 11538.9 11594.3 11624.0 11626.8 8543.1 11098.4 11347.4 11409.6 11616.1 41921.0 42388.9 42402.6 42420.9 42478.4 4029.3 4032.7 4061.3 4086.4 4121.8 31034.4 31687.0 31714.8 31748.9 31819.8 3050.8 3074.1 3085.5 3174.3 3222.0 370615.0 370671.0 371179.1 371295.0 371350.0 60964.0 62906.4 63357.0 63433.4 63531.1 63820.0 66292.0 66393.7 66485.0 66679.7 15721.5 16153.3 16173.6 16183.5 16195.9 11220.7 11270.9 12441.7 12493.1 12594.5 15182.5 15643.8 17129.7 17257.3 17583.0 7008.7 7084.7 7127.5 7168.0 7185.4 875.4 881.3 889.2 906.1 923.6 28872.0 30534.0 30548.4 30921.4 31480.8 1036.7 1040.9 1058.0 1076.9 1219.8 14371.6 15661.6 15869.3 15908.9 16453.6 614045.0 618047.0 618976.0 619762.0 620686.9 62687.0 62811.0 62953.7 62997.4 63176.0 1410.5 1457.3 1468.1 1471.8 1474.9 26539.6 28808.0 30124.5 30651.7 30726.4 51707.0 52253.7 52270.5 52295.7 52302.5 448989.0 451729.0 451794.0 452055.0 453803.0 22555.0 23769.3 24436.4 24512.4 41842.6 35424.5 36881.4 42119.6 44475.3 45023.9 36896.8 37274.8 37552.0 38138.8 38490.4 36429.3 36553.3 37272.8 37887.8 38060.8 36350.6 37097.4 38086.2 38468.8 38560.0 29099.3 30449.4 31366.8 31399.0 32080.5 23635.5 24520.5 24548.8 24831.4 24912.0 04:54:24 INFO - PROCESS | 2005 | 04:54:24 INFO - PROCESS | 2005 | [#2] jquery.html Cycles:180 Average:42006.28 Median:22804.27 stddev:122039.61 (535.2%) stddev-sans-first:122341.97 04:54:25 INFO - PROCESS | 2005 | Values: 396.3 398.4 402.8 403.9 425.4 20534.5 21260.3 21449.0 21722.7 21834.5 21735.6 21770.3 21842.8 22330.6 22598.5 5634.8 5909.4 5969.6 5969.7 5976.7 5660.8 5826.1 5832.9 5920.0 5947.7 5718.1 5841.3 5851.5 5867.9 5872.7 5610.4 5762.0 5828.7 5835.0 5839.1 5128.7 5145.7 5164.8 5166.8 5167.0 27060.3 27248.7 27349.3 27413.9 27659.2 2759.1 2780.8 2782.5 2791.2 2878.0 15084.5 15286.5 16150.4 16506.8 16804.7 1780.0 1832.9 1841.9 1843.9 1886.3 115032.0 119190.0 145357.0 154103.2 174542.0 18486.9 18523.8 22310.4 22804.9 22815.3 34170.5 35014.9 35198.0 37621.8 41290.4 10909.5 11018.8 11366.9 11375.8 11596.7 9048.7 9050.3 9065.7 9228.7 9236.0 9131.4 10450.5 10706.0 10822.3 10921.9 3465.8 4021.6 4118.8 4130.8 4131.9 875.6 1002.8 1019.6 1040.4 1070.6 22077.1 22306.0 22640.7 22736.9 22803.7 915.7 1021.9 1026.5 1049.9 1078.2 11228.6 11521.3 11587.8 11636.1 11657.6 705659.4 722928.0 729913.0 749917.0 752887.0 124704.0 140777.0 150050.5 161452.0 164604.0 1041.4 1066.0 1088.0 1093.4 1093.4 15948.9 19808.5 20899.8 20930.7 21127.8 40526.2 56229.6 57093.1 58211.1 63412.7 90111.1 90336.5 90420.0 91192.5 91843.0 8138.0 8391.2 8640.3 8848.5 8849.3 11813.0 12878.2 13338.1 13395.9 13884.4 11345.8 11366.3 11643.7 11658.8 11799.1 9317.7 10984.5 11582.6 11872.0 11983.9 9138.2 10654.1 11593.7 11974.4 12052.4 7706.4 8401.5 8403.1 8678.7 8903.8 9604.8 9868.8 11315.3 11428.3 11459.5 04:54:25 INFO - PROCESS | 2005 | 04:54:25 INFO - PROCESS | 2005 | [#3] mootools.html Cycles:180 Average:5460.51 Median:5180.06 stddev:2989.01 (57.7%) stddev-sans-first:2982.14 04:54:25 INFO - PROCESS | 2005 | Values: 1442.5 1461.1 1482.3 1488.6 1499.5 8065.2 8495.9 8502.1 8503.5 8512.1 7403.8 7676.2 7690.0 8092.4 8341.2 2296.0 2335.8 2336.2 2337.9 2341.4 2326.8 2354.1 2355.2 2362.4 2363.4 2314.4 2315.6 2332.7 2335.8 2341.2 2264.1 2283.3 2288.3 2303.3 2304.1 2263.3 2326.6 2331.5 2336.8 2337.0 8473.7 8553.5 8572.6 8572.8 8589.7 5019.8 5179.3 5184.9 5187.1 5188.6 3207.4 3318.7 3422.6 3464.3 3475.3 1129.4 1146.3 1191.3 1203.4 1212.2 10896.6 10988.7 10996.2 11009.4 11034.1 3410.7 4634.2 4703.8 4730.8 4733.0 9503.7 9509.5 9513.5 9515.7 9537.0 5250.0 5252.9 5253.2 5254.7 5256.7 4283.9 4435.2 4501.7 4712.2 4776.6 3756.9 3802.7 3862.9 3896.5 3906.3 1134.6 1218.9 1264.7 1271.4 1285.2 779.9 851.1 892.4 894.8 925.9 5335.3 5363.8 5561.0 5752.1 5786.9 962.8 990.5 1003.2 1013.8 1030.1 3564.7 3579.5 3745.6 3757.4 3809.2 9829.5 10148.6 10166.0 10183.2 10212.2 9347.2 9803.1 9824.4 10100.6 10129.5 7613.4 7820.7 7833.3 7842.5 7851.3 4819.6 5363.8 5695.8 5728.0 5825.2 8968.0 9152.3 9245.1 9290.6 9426.7 9316.7 9408.7 9577.4 9612.3 9622.9 7047.6 7177.1 7222.4 7312.6 7351.6 8012.2 8101.4 8106.4 8112.0 8136.7 7099.1 7172.5 7219.4 7317.3 7323.2 6962.6 6974.4 7019.4 7073.4 7223.1 6325.9 6435.2 6442.6 6456.5 6460.1 4940.9 4974.6 5019.1 5032.7 5078.6 4928.1 5033.6 5038.9 5091.6 5180.8 04:54:25 INFO - PROCESS | 2005 | 04:54:25 INFO - PROCESS | 2005 | [#4] prototype.html Cycles:180 Average:4484.63 Median:4929.64 stddev:1366.08 (27.7%) stddev-sans-first:1334.04 04:54:25 INFO - PROCESS | 2005 | Values: 340.7 343.6 360.3 384.1 384.6 4060.8 4755.9 4990.7 5463.7 5511.9 4890.8 5157.4 5161.5 5279.6 5307.3 3303.0 4185.3 4193.3 4198.9 4230.7 3384.3 3747.8 4013.5 4220.9 4230.7 3937.7 4014.6 4050.1 4057.2 4060.2 3962.8 4011.3 4020.2 4038.4 4040.0 3488.5 3496.2 3501.0 3513.6 3519.6 4702.6 4926.5 5076.1 5203.0 5241.4 4569.1 4571.5 4613.3 4616.0 4618.3 4449.8 5074.7 5079.9 5523.2 5572.2 2942.8 3747.9 3787.9 3834.3 3837.4 4722.7 5660.7 5769.3 5881.8 5898.4 3901.5 3901.6 3901.7 3902.7 3922.5 3823.3 3914.7 3953.0 3953.6 3959.9 4019.7 4032.7 4179.9 4426.8 4547.3 5429.7 5517.5 5588.0 5656.7 5708.8 1224.9 1249.6 1255.9 1264.5 1376.7 836.0 856.0 983.3 984.1 998.5 4500.8 4564.9 4852.8 4913.9 5064.9 4599.6 5492.8 5510.1 5568.9 5617.2 3899.5 4319.7 4944.1 4948.9 5063.9 2727.4 2826.8 2856.7 2863.8 2907.4 4785.1 4839.9 5241.9 5691.4 5702.1 4725.0 4923.5 5434.8 5638.2 5665.9 5475.7 5674.7 5677.9 5691.5 5725.4 4250.5 5504.2 5745.5 5828.7 5867.6 4932.8 5518.2 5781.2 5811.2 5811.5 5787.8 6010.0 6020.9 6026.8 6051.2 3848.5 3904.7 3911.1 3916.2 3924.9 5768.8 5777.3 5807.4 5808.4 5820.4 4922.6 5171.6 5625.5 5656.0 5659.6 5181.4 5249.0 5657.9 5666.7 5669.8 4708.7 5271.6 5298.5 5330.5 5451.0 5599.0 5617.7 5618.8 5625.1 5645.2 5285.5 5448.7 5476.9 5487.9 5530.1 04:54:25 INFO - PROCESS | 2005 | 04:54:25 INFO - PROCESS | 2005 | [#5] yui.html Cycles:180 Average:20344.75 Median:22554.82 stddev:29120.12 (129.1%) stddev-sans-first:29164.54 04:54:25 INFO - PROCESS | 2005 | Values: 721.1 725.1 765.1 801.8 831.3 14708.2 15606.5 15607.4 15610.4 15676.9 14011.6 14171.6 14449.9 14526.9 14695.1 851.4 860.9 876.4 878.2 878.9 682.7 703.5 706.0 873.3 877.4 881.4 886.2 913.6 921.0 924.6 869.0 870.6 871.3 889.3 912.0 527.4 673.8 674.3 680.6 682.9 12463.1 13220.9 13582.3 14893.7 15201.8 14368.9 14444.6 14488.5 14577.9 14632.8 11898.1 11909.7 12034.9 12085.9 12189.6 3346.4 3391.5 3476.2 3486.6 3505.4 91092.0 107022.0 107539.0 109955.9 110009.0 9594.1 11078.0 11592.2 12015.6 12113.8 23041.5 23382.0 23633.6 23678.8 23700.5 7848.5 7871.9 8045.1 8045.2 8114.9 4235.4 4300.0 4301.2 4311.2 4316.9 3493.4 3562.5 3631.3 3662.1 3665.9 568.4 659.0 664.0 669.9 670.7 671.0 678.0 692.5 714.0 727.6 9150.2 9272.7 9819.7 10427.5 10429.9 566.0 567.6 615.3 660.8 714.1 3905.7 4878.9 4989.0 4989.5 5133.6 99024.5 101370.0 103618.0 104395.0 106223.5 83545.6 83616.0 85332.0 87042.6 87093.0 79035.6 79222.6 79838.2 79848.2 80689.6 9436.0 9785.9 9805.6 9808.6 9881.9 40874.2 47343.5 48488.8 49056.0 50387.0 65223.7 66025.7 67429.7 68393.7 69183.7 10864.3 11151.2 11928.0 12217.4 12309.0 12886.7 13163.8 13260.9 13584.4 13730.2 12611.7 13289.0 13547.9 13692.1 14125.3 13860.4 14055.9 14088.0 14244.6 14662.3 13484.5 13554.6 13619.4 13799.8 14061.2 11338.5 11379.1 11535.4 12044.1 12074.6 10995.3 11027.4 11454.4 11610.5 11621.2 04:54:25 INFO - PROCESS | 2005 | -------- Summary: end -------- 04:54:25 INFO - PROCESS | 2005 | 04:54:25 INFO - TEST-INFO | 2005: exit 0 04:54:25 INFO - TEST-OK | dromaeo_css | took 1119419ms 04:54:25 INFO - TEST-START | kraken 04:54:25 INFO - operating with platform_type : mac_ 04:54:25 INFO - Initialising browser for kraken test... 04:54:25 INFO - TEST-INFO | started process 2008 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/tmpqCcPnS/profile http://localhost:49335/getInfo.html) 04:54:27 INFO - PROCESS | 2008 | __metrics Screen width/height:1600/1200 04:54:27 INFO - PROCESS | 2008 | colorDepth:24 04:54:27 INFO - PROCESS | 2008 | Browser inner width/height: 1024/689 04:54:27 INFO - PROCESS | 2008 | __metrics 04:54:28 INFO - PROCESS | 2008 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:54:28 INFO - PROCESS | 2008 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:54:28 INFO - TEST-INFO | 2008: exit 0 04:54:28 INFO - Browser initialized. 04:54:28 INFO - Running cycle 1/1 for kraken test... 04:54:28 INFO - TEST-INFO | started process 2010 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/T/tmpqCcPnS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:54:40 INFO - PROCESS | 2010 | RSS: Main: 235692032 04:54:40 INFO - PROCESS | 2010 | 04:54:43 INFO - PROCESS | 2010 | Cycle 1(1): loaded http://localhost:49335/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49335/tests/kraken/driver.html?testName=audio-beat-detection) 04:54:44 INFO - PROCESS | 2010 | RSS: Main: 287760384 04:54:44 INFO - PROCESS | 2010 | 04:54:46 INFO - PROCESS | 2010 | Cycle 1(1): loaded http://localhost:49335/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49335/tests/kraken/driver.html?testName=audio-dft) 04:54:47 INFO - PROCESS | 2010 | RSS: Main: 287076352 04:54:47 INFO - PROCESS | 2010 | 04:54:51 INFO - PROCESS | 2010 | Cycle 1(1): loaded http://localhost:49335/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49335/tests/kraken/driver.html?testName=audio-fft) 04:54:51 INFO - PROCESS | 2010 | RSS: Main: 379965440 04:54:51 INFO - PROCESS | 2010 | 04:54:53 INFO - PROCESS | 2010 | Cycle 1(1): loaded http://localhost:49335/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49335/tests/kraken/driver.html?testName=audio-oscillator) 04:54:54 INFO - PROCESS | 2010 | RSS: Main: 282091520 04:54:54 INFO - PROCESS | 2010 | 04:54:56 INFO - PROCESS | 2010 | Cycle 1(1): loaded http://localhost:49335/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49335/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:54:56 INFO - PROCESS | 2010 | RSS: Main: 285782016 04:54:56 INFO - PROCESS | 2010 | 04:54:59 INFO - PROCESS | 2010 | Cycle 1(1): loaded http://localhost:49335/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49335/tests/kraken/driver.html?testName=imaging-darkroom) 04:55:00 INFO - PROCESS | 2010 | RSS: Main: 328851456 04:55:00 INFO - PROCESS | 2010 | 04:55:03 INFO - PROCESS | 2010 | Cycle 1(1): loaded http://localhost:49335/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49335/tests/kraken/driver.html?testName=imaging-desaturate) 04:55:03 INFO - PROCESS | 2010 | RSS: Main: 328310784 04:55:03 INFO - PROCESS | 2010 | 04:55:06 INFO - PROCESS | 2010 | Cycle 1(1): loaded http://localhost:49335/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49335/tests/kraken/driver.html?testName=json-parse-financial) 04:55:07 INFO - PROCESS | 2010 | RSS: Main: 328540160 04:55:07 INFO - PROCESS | 2010 | 04:55:08 INFO - PROCESS | 2010 | Cycle 1(1): loaded http://localhost:49335/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49335/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:55:09 INFO - PROCESS | 2010 | RSS: Main: 304345088 04:55:09 INFO - PROCESS | 2010 | 04:55:11 INFO - PROCESS | 2010 | Cycle 1(1): loaded http://localhost:49335/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49335/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:55:12 INFO - PROCESS | 2010 | RSS: Main: 306757632 04:55:12 INFO - PROCESS | 2010 | 04:55:14 INFO - PROCESS | 2010 | Cycle 1(1): loaded http://localhost:49335/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49335/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:55:14 INFO - PROCESS | 2010 | RSS: Main: 308072448 04:55:14 INFO - PROCESS | 2010 | 04:55:17 INFO - PROCESS | 2010 | Cycle 1(1): loaded http://localhost:49335/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49335/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:55:18 INFO - PROCESS | 2010 | RSS: Main: 323727360 04:55:18 INFO - PROCESS | 2010 | 04:55:21 INFO - PROCESS | 2010 | Cycle 1(1): loaded http://localhost:49335/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49335/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:55:22 INFO - PROCESS | 2010 | RSS: Main: 317939712 04:55:22 INFO - PROCESS | 2010 | 04:55:23 INFO - PROCESS | 2010 | Cycle 1(1): loaded http://localhost:49335/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49335/tests/kraken/driver.html?testName=ai-astar) 04:55:24 INFO - PROCESS | 2010 | RSS: Main: 362446848 04:55:24 INFO - PROCESS | 2010 | 04:55:24 INFO - PROCESS | 2010 | __start_tp_report 04:55:24 INFO - PROCESS | 2010 | _x_x_mozilla_page_load 04:55:24 INFO - PROCESS | 2010 | _x_x_mozilla_page_load_details 04:55:24 INFO - PROCESS | 2010 | |i|pagename|runs| 04:55:24 INFO - PROCESS | 2010 | |0;ai-astar;113;114;115;114;113;113;114;114;114;112 04:55:24 INFO - PROCESS | 2010 | |1;audio-beat-detection;140;110;109;145;111;111;111;108;131;112 04:55:24 INFO - PROCESS | 2010 | |2;audio-dft;188;199;257;197;184;185;180;185;185;185 04:55:24 INFO - PROCESS | 2010 | |3;audio-fft;79;61;76;114;87;63;60;58;74;59 04:55:24 INFO - PROCESS | 2010 | |4;audio-oscillator;91;70;85;69;67;70;81;69;68;83 04:55:24 INFO - PROCESS | 2010 | |5;imaging-gaussian-blur;87;85;87;84;87;83;87;83;86;84 04:55:24 INFO - PROCESS | 2010 | |6;imaging-darkroom;93;93;101;150;127;95;93;92;93;92 04:55:24 INFO - PROCESS | 2010 | |7;imaging-desaturate;86;87;85;87;88;87;85;81;85;85 04:55:24 INFO - PROCESS | 2010 | |8;json-parse-financial;57;54;55;55;55;57;55;56;56;55 04:55:24 INFO - PROCESS | 2010 | |9;json-stringify-tinderbox;65;69;76;75;73;71;70;70;69;71 04:55:24 INFO - PROCESS | 2010 | |10;stanford-crypto-aes;88;86;87;86;85;89;90;87;86;87 04:55:24 INFO - PROCESS | 2010 | |11;stanford-crypto-ccm;140;166;132;145;150;155;138;140;181;149 04:55:24 INFO - PROCESS | 2010 | |12;stanford-crypto-pbkdf2;172;177;175;174;171;173;171;171;173;174 04:55:24 INFO - PROCESS | 2010 | |13;stanford-crypto-sha256-iterative;69;67;67;68;66;66;67;67;66;65 04:55:24 INFO - PROCESS | 2010 | __end_tp_report 04:55:24 INFO - PROCESS | 2010 | __start_cc_report 04:55:24 INFO - PROCESS | 2010 | _x_x_mozilla_cycle_collect,1937 04:55:24 INFO - PROCESS | 2010 | __end_cc_report 04:55:24 INFO - PROCESS | 2010 | __startTimestamp1484398524094__endTimestamp 04:55:24 INFO - PROCESS | 2010 | 04:55:24 INFO - PROCESS | 2010 | ------- Summary: start ------- 04:55:24 INFO - PROCESS | 2010 | Number of tests: 14 04:55:24 INFO - PROCESS | 2010 | 04:55:24 INFO - PROCESS | 2010 | [#0] ai-astar Cycles:10 Average:113.60 Median:114.00 stddev:0.84 (0.7%) stddev-sans-first:0.87 04:55:24 INFO - PROCESS | 2010 | Values: 113.0 114.0 115.0 114.0 113.0 113.0 114.0 114.0 114.0 112.0 04:55:24 INFO - PROCESS | 2010 | 04:55:24 INFO - PROCESS | 2010 | [#1] audio-beat-detection Cycles:10 Average:118.80 Median:111.50 stddev:14.16 (12.7%) stddev-sans-first:12.77 04:55:24 INFO - PROCESS | 2010 | Values: 140.0 110.0 109.0 145.0 111.0 111.0 111.0 108.0 131.0 112.0 04:55:24 INFO - PROCESS | 2010 | 04:55:24 INFO - PROCESS | 2010 | [#2] audio-dft Cycles:10 Average:194.50 Median:186.50 stddev:22.75 (12.2%) stddev-sans-first:24.00 04:55:24 INFO - PROCESS | 2010 | Values: 188.0 199.0 257.0 197.0 184.0 185.0 180.0 185.0 185.0 185.0 04:55:24 INFO - PROCESS | 2010 | 04:55:24 INFO - PROCESS | 2010 | [#3] audio-fft Cycles:10 Average:73.10 Median:68.50 stddev:17.50 (25.6%) stddev-sans-first:18.43 04:55:24 INFO - PROCESS | 2010 | Values: 79.0 61.0 76.0 114.0 87.0 63.0 60.0 58.0 74.0 59.0 04:55:24 INFO - PROCESS | 2010 | 04:55:24 INFO - PROCESS | 2010 | [#4] audio-oscillator Cycles:10 Average:75.30 Median:75.50 stddev:8.76 (11.6%) stddev-sans-first:7.21 04:55:24 INFO - PROCESS | 2010 | Values: 91.0 70.0 85.0 69.0 67.0 70.0 81.0 69.0 68.0 83.0 04:55:24 INFO - PROCESS | 2010 | 04:55:24 INFO - PROCESS | 2010 | [#5] imaging-gaussian-blur Cycles:10 Average:85.30 Median:86.50 stddev:1.70 (2.0%) stddev-sans-first:1.69 04:55:24 INFO - PROCESS | 2010 | Values: 87.0 85.0 87.0 84.0 87.0 83.0 87.0 83.0 86.0 84.0 04:55:24 INFO - PROCESS | 2010 | 04:55:24 INFO - PROCESS | 2010 | [#6] imaging-darkroom Cycles:10 Average:102.90 Median:93.00 stddev:19.71 (21.2%) stddev-sans-first:20.57 04:55:24 INFO - PROCESS | 2010 | Values: 93.0 93.0 101.0 150.0 127.0 95.0 93.0 92.0 93.0 92.0 04:55:24 INFO - PROCESS | 2010 | 04:55:24 INFO - PROCESS | 2010 | [#7] imaging-desaturate Cycles:10 Average:85.60 Median:86.50 stddev:1.96 (2.3%) stddev-sans-first:2.07 04:55:24 INFO - PROCESS | 2010 | Values: 86.0 87.0 85.0 87.0 88.0 87.0 85.0 81.0 85.0 85.0 04:55:24 INFO - PROCESS | 2010 | 04:55:24 INFO - PROCESS | 2010 | [#8] json-parse-financial Cycles:10 Average:55.50 Median:55.50 stddev:0.97 (1.8%) stddev-sans-first:0.87 04:55:24 INFO - PROCESS | 2010 | Values: 57.0 54.0 55.0 55.0 55.0 57.0 55.0 56.0 56.0 55.0 04:55:24 INFO - PROCESS | 2010 | 04:55:24 INFO - PROCESS | 2010 | [#9] json-stringify-tinderbox Cycles:10 Average:70.90 Median:71.00 stddev:3.18 (4.5%) stddev-sans-first:2.55 04:55:24 INFO - PROCESS | 2010 | Values: 65.0 69.0 76.0 75.0 73.0 71.0 70.0 70.0 69.0 71.0 04:55:24 INFO - PROCESS | 2010 | 04:55:24 INFO - PROCESS | 2010 | [#10] stanford-crypto-aes Cycles:10 Average:87.10 Median:87.00 stddev:1.52 (1.8%) stddev-sans-first:1.58 04:55:24 INFO - PROCESS | 2010 | Values: 88.0 86.0 87.0 86.0 85.0 89.0 90.0 87.0 86.0 87.0 04:55:24 INFO - PROCESS | 2010 | 04:55:24 INFO - PROCESS | 2010 | [#11] stanford-crypto-ccm Cycles:10 Average:149.60 Median:149.50 stddev:14.66 (9.8%) stddev-sans-first:15.13 04:55:24 INFO - PROCESS | 2010 | Values: 140.0 166.0 132.0 145.0 150.0 155.0 138.0 140.0 181.0 149.0 04:55:24 INFO - PROCESS | 2010 | 04:55:24 INFO - PROCESS | 2010 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.10 Median:173.50 stddev:1.97 (1.1%) stddev-sans-first:2.05 04:55:24 INFO - PROCESS | 2010 | Values: 172.0 177.0 175.0 174.0 171.0 173.0 171.0 171.0 173.0 174.0 04:55:24 INFO - PROCESS | 2010 | 04:55:24 INFO - PROCESS | 2010 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.00 stddev:1.14 (1.7%) stddev-sans-first:0.88 04:55:24 INFO - PROCESS | 2010 | Values: 69.0 67.0 67.0 68.0 66.0 66.0 67.0 67.0 66.0 65.0 04:55:24 INFO - PROCESS | 2010 | -------- Summary: end -------- 04:55:24 INFO - PROCESS | 2010 | 04:55:24 INFO - TEST-INFO | 2010: exit 0 04:55:24 INFO - TEST-OK | kraken | took 59382ms 04:55:24 INFO - SUITE-END | took 1178s 04:55:25 INFO - Completed test suite (00:19:39) 04:55:25 INFO - javascript benchmark 04:55:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3227.8708851645933, 3285.3265080658484, 3289.999999999999, 3329.417351963406, 3356.7985920844735, 5548.77804887804, 5579.079451890439, 5609.158626206061, 5630.943690563098, 5669.914951275734, 5622.353429355615, 5665.036943719567, 5674.886502269963, 5675.886482270352, 5693.146028095788, 5144.43411224765, 5181.0674078665825, 5188.533032027117, 5222.529972302492, 5254.185601231815, 5272.604554658396, 5275.6043296752705, 5277.577793776489, 5280.841574752763, 5282.894342113155, 5267.130923397634, 5280.551153151987, 5282.973585132069, 5285.048691235576, 5286.101362768339, 5281.841544753625, 5287.339082614654, 5287.4976877196605, 5288.153895376721, 5292.126799078147, 4932.753362331869, 5176.482351764831, 5233.450487698813, 5237.109691352479, 5239.947600523984, 5648.350439699446, 5699.002674531982, 5762.07806750922, 5768.163616275659, 5777.277840269966, 6109.908351374733, 6185.319614842364, 6254.0931564923285, 6258.34287399821, 6302.873942521124, 6161.19904412428, 6173.074038894157, 6231.87536249277, 6232.719527621268, 6235.0, 5832.8541786454825, 5833.212516310328, 5835.824925252249, 5843.474087332075, 5876.529877609823, 6299.590526615755, 6304.684765761694, 6335.68321583919, 6336.6831658416895, 6339.936600634027, 5936.5844390892225, 5983.521318294526, 5991.7902873399225, 6077.3314935357075, 6174.567780255429, 6181.690915454209, 6248.0, 6265.8746825063245, 6270.592411493239, 6274.9686251569365, 6114.2357205349335, 6213.689315534205, 6220.34686357935, 6226.1905952225925, 6264.123022776815, 6105.247473116927, 6133.059244993061, 6246.968765156145, 6260.0, 6266.905996410058, 4955.306257124005, 4987.750612469435, 5003.824866129741, 5005.3242812220615, 5032.446430892599, 4472.709273897186, 4490.7754612269255, 4497.8425755098415, 4502.279635258343, 4520.299353600197, 5614.887702246014, 5722.256106706185, 5736.368999410061, 5745.683987380734, 5788.0, 5139.357580302462, 6112.716259964451, 6224.0, 6230.127782110508, 6255.593386429868, 5695.829125126253, 5725.026745453283, 5738.856528586819, 5749.965006298823, 5775.913361299584, 5333.57331413486, 5394.757235924314, 5395.676259424447, 5423.2136340230445, 5449.455054494519, 6235.781747638993, 6236.095766113888, 6255.374462553799, 6270.7805226816845, 6309.842253943688, 5019.7239151847, 6168.537359698131, 6183.938160618336, 6195.535334849814, 6291.245050593775, 5160.561352285098, 6256.874862502816, 6289.993601023814, 6305.6216627000695, 6312.116303717391, 6218.098375735583, 6226.377362263737, 6230.15892854477, 6230.875382492415, 6241.843953901189, 6136.6011209271255, 6140.565599444434, 6268.435840774352, 6284.402981716729, 6315.526335524946, 6089.847753806191, 6126.448619624255, 6144.324124346408, 6166.938330616636, 6173.59871608344, 6108.905670139014, 6112.326841499263, 6112.541559383153, 6135.171751813448, 6146.770645870754, 5787.276590426197, 5925.05199168131, 5959.046552551571, 5983.850403739942, 5988.850278743066, 4976.701397916137, 5970.97014514942, 5983.880322393441, 6010.278766548042, 6124.356942520971, 5826.126081087871, 5881.353051164283, 5906.26171728534, 5910.911336329872, 5925.140854576149], "value": 5681.3522514586475, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [441.0363356066992, 453.18653017832986, 493.65197535737303, 500.5695102212099, 519.2237604780853, 28497.85751071244, 32197.67802321979, 41867.0, 43514.782426087906, 43531.56468435315, 42527.57472425275, 44858.77570612142, 44955.0, 44955.10089798202, 44986.775066124705, 9314.67398641046, 9517.14415688941, 9529.952350238274, 9531.952340238324, 9541.0, 8566.571671416435, 8788.956055219714, 9412.058794120601, 11330.943345283304, 11646.475908584134, 11529.365884876328, 11596.826047609293, 11611.129165312594, 11616.767664646703, 11622.07023438123, 8573.356998225096, 11538.942305288461, 11594.304341739522, 11624.0, 11626.767464650744, 8543.14568543147, 11098.389588572625, 11347.375894325809, 11409.60066397672, 11616.128790340757, 41921.0, 42388.94027649303, 42402.57597424048, 42420.93947651303, 42478.362824557655, 4029.2875976294836, 4032.717709760318, 4061.2892743770017, 4086.4483294755123, 4121.773302468363, 31034.379312413625, 31687.0, 31714.841425792954, 31748.888788892276, 31819.840900795578, 3050.801697889652, 3074.13924101252, 3085.490894002487, 3174.349258402022, 3221.983890080558, 370615.0, 370671.0, 371179.1441042778, 371295.0, 371349.9999999973, 60964.0, 62906.370936290965, 63357.04964425537, 63433.36566634367, 63531.094067178055, 63820.0, 66292.0, 66393.6680316605, 66485.00272495917, 66679.66660166669, 15721.528354149164, 16153.273102710406, 16173.595660108356, 16183.514494565183, 16195.919020405057, 11220.719482013015, 11270.943645281885, 12441.688957776129, 12493.063020273516, 12594.496220151092, 15182.46861359847, 15643.765343519857, 17129.657406852042, 17257.309707611807, 17583.0, 7008.684609192598, 7084.716611335489, 7127.4654400920135, 7167.964160179165, 7185.389241914496, 875.4353442029856, 881.3389957531851, 889.226373055446, 906.1301150895083, 923.584387025841, 28872.0, 30533.95772937865, 30548.38903221923, 30921.381572368427, 31480.842595786875, 1036.6993571864075, 1040.8594839696543, 1057.9947100264603, 1076.9084627806567, 1219.7802197802198, 14371.568852934428, 15661.608459788597, 15869.285882135331, 15908.886377953431, 16453.58866028359, 614045.0, 618047.0, 618976.0, 619762.0, 620686.8965655233, 62687.0, 62811.0, 62953.68523157446, 62997.37002629915, 63176.0, 1410.4710733474947, 1457.2859298943442, 1468.12646475347, 1471.8454562271022, 1474.9115053096848, 26539.601905971813, 28808.0, 30124.54813177848, 30651.693483065777, 30726.385472290876, 51707.0, 52253.73873130762, 52270.47729522656, 52295.73852130715, 52302.476975231286, 448989.0, 451729.0, 451794.0, 452055.0, 453803.0, 22554.985025674214, 23769.286921392384, 24436.389090272885, 24512.387190320384, 41842.58157418387, 35424.46863297001, 36881.44677829889, 42119.57880421279, 44475.33287000633, 45023.87440314018, 36896.81551592225, 37274.813625931696, 37552.0, 38138.80930595329, 38490.422643660924, 36429.27141457103, 36553.268934621694, 37272.81363593165, 37887.81056094702, 38060.80969595134, 36350.63649363472, 37097.443538347485, 38086.23827523489, 38468.807655961544, 38560.0, 29099.272518187216, 30449.391012180076, 31366.843165784026, 31399.0, 32080.51879221767, 23635.527289454458, 24520.509589808462, 24548.754512454645, 24831.379215519755, 24912.0], "value": 19837.465228551668, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [396.25701809107903, 398.4262661767055, 402.80262671291075, 403.90710136668565, 425.4426701021662, 20534.486637834063, 21260.255891043817, 21449.0, 21722.674159887614, 21834.45413864652, 21735.565288694215, 21770.346889593337, 21842.798646074458, 22330.55338893221, 22598.548029039408, 5634.802781902645, 5909.438603332676, 5969.641821490724, 5969.731362088716, 5976.731047102869, 5660.801871934483, 5826.126081087828, 5832.854178645546, 5919.970400147993, 5947.672877991708, 5718.142278658213, 5841.299044114712, 5851.473367396933, 5867.8533036674, 5872.7063646817705, 5610.410906854762, 5762.0, 5828.708564571797, 5835.0, 5839.124131380306, 5128.666636668605, 5145.691258524501, 5164.793408263665, 5166.844994650167, 5167.0, 27060.323491912663, 27248.727512724818, 27349.316267093283, 27413.86293068522, 27659.170224893085, 2759.089500464842, 2780.78800592545, 2782.5130602144545, 2791.204506715597, 2878.0, 15084.472043478536, 15286.464973725866, 16150.434734784227, 16506.83493165077, 16804.74792878108, 1779.9555011124696, 1832.9175187116612, 1841.8618603604784, 1843.8985855777926, 1886.2643569008098, 115032.0, 119190.0, 145357.0, 154103.22948385298, 174542.0, 18486.907565462086, 18523.785998373147, 22310.442238944157, 22804.88597557035, 22815.31554053381, 34170.487442688376, 35014.9495515135, 35198.0, 37621.81189094037, 41290.38064429036, 10909.454527273763, 11018.834717479243, 11366.943165284121, 11375.772484550263, 11596.652100437, 9048.728538143867, 9050.27597792175, 9065.68270110543, 9228.723138305862, 9235.953820230856, 9131.360804743737, 10450.477476126163, 10706.036456718934, 10822.288571100964, 10921.945390273157, 3465.7920524768597, 4021.577734337911, 4118.814653340607, 4130.752154870717, 4131.938020929689, 875.5534677314615, 1002.8445590933271, 1019.6023550815188, 1040.4225654761528, 1070.6092276319087, 22077.116915323528, 22305.99623016968, 22640.660390094163, 22736.863156842093, 22803.657945130835, 915.6520522201521, 1021.897810218987, 1026.5021464589668, 1049.8687664041995, 1078.2290662176424, 11228.550857965753, 11521.308721476738, 11587.768244635061, 11636.12729045325, 11657.591984280509, 705659.4151087737, 722928.0, 729913.0, 749917.0, 752887.0, 124704.0, 140777.0, 150050.4944456109, 161452.0, 164604.0, 1041.4480325427535, 1065.9946700266448, 1088.0, 1093.4423444043596, 1093.4423444043596, 15948.920255398649, 19808.504787379854, 20899.791002089783, 20930.744155350727, 21127.788722113197, 40526.1894762109, 56229.59426014382, 57093.14360284682, 58211.12683309669, 63412.68293658502, 90111.09888901027, 90336.548317258, 90420.0, 91192.54403728204, 91843.0, 8138.0, 8391.244787969112, 8640.308775298086, 8848.513331766815, 8849.292056635324, 11813.0, 12878.162919410208, 13338.06633535682, 13395.933020334836, 13884.444622214998, 11345.829812552653, 11366.261193022758, 11643.708907277385, 11658.76682466363, 11799.05607551411, 9317.673881414388, 10984.450777461256, 11582.594609188975, 11872.0, 11983.940080299542, 9138.223251023737, 10654.094401975919, 11593.6521904343, 11974.401279936143, 12052.397380131133, 7706.422018348534, 8401.53791541471, 8403.075661677089, 8678.739637810875, 8903.821923561622, 9604.807903841744, 9868.802623947337, 11315.264507806965, 11428.314301141958, 11459.541618335506], "value": 11163.79965471883, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1442.5023366938403, 1461.1452300404262, 1482.2588705647177, 1488.5534339698088, 1499.505163296112, 8065.193480651939, 8495.872561911561, 8502.107278735737, 8503.532305723184, 8512.063672995966, 7403.777886663395, 7676.232376762321, 7689.961550192241, 8092.39307051972, 8341.165883411655, 2295.9770402296012, 2335.7664233576593, 2336.2407217654245, 2337.883105844701, 2341.356127065054, 2326.7789559991775, 2354.0819080558595, 2355.1639168095335, 2362.4093976505874, 2363.420961864346, 2314.4098254944965, 2315.583195024895, 2332.7433982261937, 2335.754745751697, 2341.239097293378, 2264.094362255103, 2283.2807665585287, 2288.2791920544973, 2303.285981345788, 2304.101400453824, 2263.2644390572964, 2326.5579539887535, 2331.5336932613545, 2336.7896889280046, 2337.018452250059, 8473.661053557851, 8553.486790792573, 8572.61423235956, 8572.828543429096, 8589.656413743443, 5019.84940451787, 5179.326687530634, 5184.948150518484, 5187.066328060948, 5188.584913206934, 3207.4226639204935, 3318.7050253409616, 3422.6064002639764, 3464.34177506273, 3475.33968545978, 1129.3675541696593, 1146.2663895107055, 1191.332853601977, 1203.3862730007759, 1212.1514939542355, 10896.564137434492, 10988.725281868017, 10996.23026388153, 11009.449527523591, 11034.117270618251, 3410.7271418286477, 4634.21218392874, 4703.811847526061, 4730.810767569327, 4733.0, 9503.66737164196, 9509.476978766095, 9513.476758778334, 9515.666951656658, 9537.0, 5250.0, 5252.868678282997, 5253.23828044939, 5254.65844720092, 5256.684598924076, 4283.914321713548, 4435.246008178618, 4501.729896206238, 4712.151812673683, 4776.570108690165, 3756.887293381203, 3802.676772474371, 3862.942055869164, 3896.493455850721, 3906.277338692351, 1134.597217987619, 1218.8781121887741, 1264.72808346206, 1271.3643178410794, 1285.2288626824018, 779.8713212320017, 851.089334412173, 892.3619611977467, 894.7584152278979, 925.8703781470599, 5335.33308336458, 5363.785448582091, 5560.972195139079, 5752.108423194411, 5786.855328616734, 962.7544976031068, 990.5146478225762, 1003.2174903575223, 1013.8428543575758, 1030.07808011829, 3564.7326450516316, 3579.51676523666, 3745.5879853216125, 3757.3612485877466, 3809.219269932909, 9829.45937973404, 10148.644797432054, 10166.034226748447, 10183.236257280734, 10212.183025357954, 9347.158755711882, 9803.117719405287, 9824.4105353679, 10100.646477373404, 10129.544170512345, 7613.439244954771, 7820.7262745804765, 7833.255840695125, 7842.52944823301, 7851.254130857559, 4819.59033482158, 5363.766333743183, 5695.772169113189, 5727.997600419826, 5825.184474173704, 8968.0, 9152.313576481658, 9245.075492450702, 9290.58192381331, 9426.717198484057, 9316.720498385059, 9408.717738467856, 9577.377470464398, 9612.279079069238, 9622.855657165008, 7047.647617619201, 7177.066981292399, 7222.3860971817985, 7312.634368281671, 7351.595662238628, 8012.158723333966, 8101.35189184852, 8106.39202059836, 8112.0, 8136.7152149674475, 7099.148102227766, 7172.462065345016, 7219.350258476762, 7317.341439270491, 7323.231060738546, 6962.582245065312, 6974.407175390149, 7019.403350715246, 7073.363397294268, 7223.097112860893, 6325.905111423424, 6435.227772667123, 6442.645654489048, 6456.548041637228, 6460.095586617971, 4940.851774446773, 4974.552290293891, 5019.121653710659, 5032.7483625819295, 5078.6444948854705, 4928.137575924271, 5033.597312214941, 5038.874028149179, 5091.592672586258, 5180.792768289226], "value": 4436.109259358126, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [340.66784884737376, 343.56561356337295, 360.3046120986495, 384.1337783298661, 384.59041121205894, 4060.776657283848, 4755.90488190236, 4990.725510096943, 5463.699496527689, 5511.862203444916, 4890.7554622268835, 5157.406898206707, 5161.535461808446, 5279.577633789298, 5307.319803499237, 3302.966970330302, 4185.3378293992755, 4193.329067349209, 4198.874033778976, 4230.661547076242, 3384.3400536895315, 3747.7563958342757, 4013.5384430790396, 4220.873373798776, 4230.661547076242, 3937.7243592948507, 4014.6386825185728, 4050.058928107704, 4057.1885622875543, 4060.2285565742413, 3962.762234265939, 4011.29802284599, 4020.1758639478835, 4038.4144299076615, 4039.97980010101, 3488.4767284907466, 3496.248306614065, 3500.9824950875336, 3513.578370595519, 3519.6128425873135, 4702.6002789762915, 4926.531979461945, 5076.137188158929, 5203.0, 5241.397239317451, 4569.058150286115, 4571.451425828922, 4613.261878099522, 4616.030633566955, 4618.284165954283, 4449.777511124431, 5074.746262686851, 5079.85703216777, 5523.232565579016, 5572.247746554204, 2942.7792915531422, 3747.906302342436, 3787.9431808522895, 3834.348160812641, 3837.4052021936363, 4722.716637001791, 5660.688662123582, 5769.336526299488, 5881.794137205177, 5898.439648233411, 3901.51231096113, 3901.6293452122004, 3901.6878649707955, 3902.746321489094, 3922.5489068756888, 3823.2926908522013, 3914.6868250539887, 3952.960470395317, 3953.5651078381356, 3959.940600890989, 4019.698522610816, 4032.697547683935, 4179.895502612399, 4426.845060422934, 4547.295169248771, 5429.728513574306, 5517.496389792511, 5587.972060139673, 5656.745446454919, 5708.771649133988, 1224.8591411987736, 1249.5938819883575, 1255.9010865492694, 1264.5068423314915, 1376.7040086381476, 836.0144656440953, 855.9957200213959, 983.2772911909741, 984.104464936904, 998.5306905754284, 4500.797464114123, 4564.931526027112, 4852.781624826891, 4913.901721965541, 5064.924026139611, 4599.6090332321455, 5492.780288788484, 5510.090835012178, 5568.860778480571, 5617.157426385993, 3899.493065901415, 4319.719218250803, 4944.060628480577, 4948.911239527299, 5063.8987220255385, 2727.359070618403, 2826.8409951919616, 2856.7428931396275, 2863.7519547155384, 2907.4039821836895, 4785.0952773407535, 4839.903201936012, 5241.947580524146, 5691.373948865621, 5702.087665973424, 4724.960508688083, 4923.4644158258525, 5434.83695489136, 5638.154276858422, 5665.943340566541, 5475.698836563947, 5674.744636491368, 5677.905541479903, 5691.4877661010705, 5725.398833122462, 4250.512320687858, 5504.22940788282, 5745.511631511368, 5828.70856457167, 5867.559933005127, 4932.753362331798, 5518.1857252800555, 5781.161731548986, 5811.215485909348, 5811.455012442322, 5787.774924305197, 6009.95661475083, 6020.8795824084145, 6026.849328766816, 6051.243594550681, 3848.4804551385205, 3904.726669133247, 3911.1395492991496, 3916.1971795782365, 3924.9402661280724, 5768.769249230152, 5777.306723193244, 5807.419258074159, 5808.419158084158, 5820.417958204315, 4922.630802689741, 5171.586273098218, 5625.521830644441, 5655.971720141373, 5659.575531835047, 5181.409295352324, 5248.9737551312, 5657.85855353603, 5666.688332141772, 5669.829905102853, 4708.717476951394, 5271.578273738015, 5298.483220470246, 5330.466953304794, 5450.972745136249, 5599.0, 5617.691026993554, 5618.775248990158, 5625.131183096569, 5645.1532270159805, 5285.462977770769, 5448.746788238648, 5476.891396812176, 5487.917681234705, 5530.087535556749], "value": 4069.722706599528, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [721.1490441279288, 725.1262229014038, 765.058977457727, 801.8476489467001, 831.256025856858, 14708.191049492274, 15606.45377411788, 15607.375704971788, 15610.375584976615, 15676.92161539192, 14011.649708757286, 14171.574852754407, 14449.927750361234, 14526.854731452682, 14695.118292902433, 851.3529717414763, 860.9311255099577, 876.4040452492303, 878.1920633017639, 878.9428687135315, 682.740558587736, 703.4969996452536, 705.9576425414491, 873.3449912565576, 877.3902138014083, 881.3918396306528, 886.2422628652506, 913.5614904845678, 920.9915142918494, 924.6070420071476, 869.0353707384797, 870.634333579898, 871.289898732531, 889.2663552569092, 911.9772005699845, 527.4303751947887, 673.7877568565887, 674.3324109131974, 680.5610381304081, 682.8804959132132, 12463.12758106933, 13220.942324614009, 13582.320883955861, 14893.73403260724, 15201.771973420407, 14368.928155359261, 14444.638884027983, 14488.492902748354, 14577.854221457756, 14632.780508292384, 11898.10764192689, 11909.702257443547, 12034.939825300817, 12085.879141208563, 12189.634310970685, 3346.4311067118406, 3391.4573668213216, 3476.235228249781, 3486.581610206766, 3505.3690335739557, 91091.99999999933, 107022.0, 107539.0, 109955.90044099536, 110009.0, 9594.05905958432, 11078.0, 11592.188546801643, 12015.579454719043, 12113.818292725617, 23041.53916921652, 23382.0, 23633.645495317585, 23678.763212368, 23700.525989480113, 7848.450608457468, 7871.881921771178, 8045.115037345888, 8045.15525869787, 8114.918850811534, 4235.449391579075, 4299.97850010748, 4301.204277208726, 4311.1808756336195, 4316.892077698083, 3493.4410494320787, 3562.4834399011997, 3631.3100510902846, 3662.121090938209, 3665.9266814663556, 568.3520786303617, 658.9934100658932, 663.9502037347219, 669.9095622091053, 670.6847781542765, 670.9899351509731, 677.9694913728894, 692.4597179638268, 713.9785806425815, 727.6434547071897, 9150.22223111043, 9272.72181834546, 9819.656312029045, 10427.530761115768, 10429.9478502607, 565.9688717120515, 567.5970061256554, 615.3446579392933, 660.7918505670698, 714.1430283659629, 3905.6680182184264, 4878.926816097762, 4988.950110498921, 4989.501049895054, 5133.589312854962, 99024.50487747515, 101370.0, 103618.0, 104395.0, 106223.46888265664, 83545.58227208946, 83616.0, 85332.0, 87042.56478717693, 87093.0, 79035.60482197552, 79222.6038869802, 79838.20161798423, 79848.20151798523, 80689.59655201803, 9435.952820235854, 9785.902140978498, 9805.558749856416, 9808.623173595128, 9881.851772223567, 40874.18251634891, 47343.52656473391, 48488.757556212, 49056.0, 50387.0, 65223.67388163029, 66025.66987165033, 67429.66285168543, 68393.65803170952, 69183.65408173128, 10864.348139111678, 11151.16366272549, 11928.0, 12217.389130543615, 12309.0, 12886.67783305425, 13163.802542962056, 13260.933695331461, 13584.388702508213, 13730.244836534086, 12611.747765044463, 13289.0, 13547.86452135466, 13692.110012849133, 14125.293735313398, 13860.4455821766, 14055.94580406494, 14088.0, 14244.572662820132, 14662.340194691478, 13484.533208550247, 13554.59336219915, 13619.387127579084, 13799.79300310476, 14061.2266325349, 11338.546458141913, 11379.146564007899, 11535.423228838692, 12044.096692747904, 12074.577389791315, 10995.334525510561, 11027.431147270578, 11454.370009649216, 11610.535578576762, 11621.24461909973], "value": 7460.837591874105, "unit": "score"}], "name": "dromaeo_css", "value": 7439.191241056923, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 115.0, 114.0, 113.0, 113.0, 114.0, 114.0, 114.0, 112.0], "value": 113.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 110.0, 109.0, 145.0, 111.0, 111.0, 111.0, 108.0, 131.0, 112.0], "value": 118.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [188.0, 199.0, 257.0, 197.0, 184.0, 185.0, 180.0, 185.0, 185.0, 185.0], "value": 194.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 61.0, 76.0, 114.0, 87.0, 63.0, 60.0, 58.0, 74.0, 59.0], "value": 73.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 70.0, 85.0, 69.0, 67.0, 70.0, 81.0, 69.0, 68.0, 83.0], "value": 75.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 87.0, 84.0, 87.0, 83.0, 87.0, 83.0, 86.0, 84.0], "value": 85.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 101.0, 150.0, 127.0, 95.0, 93.0, 92.0, 93.0, 92.0], "value": 102.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 85.0, 87.0, 88.0, 87.0, 85.0, 81.0, 85.0, 85.0], "value": 85.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 54.0, 55.0, 55.0, 55.0, 57.0, 55.0, 56.0, 56.0, 55.0], "value": 55.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 69.0, 76.0, 75.0, 73.0, 71.0, 70.0, 70.0, 69.0, 71.0], "value": 70.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 87.0, 86.0, 85.0, 89.0, 90.0, 87.0, 86.0, 87.0], "value": 87.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 166.0, 132.0, 145.0, 150.0, 155.0, 138.0, 140.0, 181.0, 149.0], "value": 149.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 177.0, 175.0, 174.0, 171.0, 173.0, 171.0, 171.0, 173.0, 174.0], "value": 173.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 67.0, 68.0, 66.0, 66.0, 67.0, 67.0, 66.0, 65.0], "value": 66.8, "unit": "score"}], "name": "kraken", "value": 1452.0999999999997, "alertThreshold": 2.0}]} 04:55:25 INFO - Return code: 0 04:55:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:55:25 ERROR - # TBPL SUCCESS # 04:55:25 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:55:25 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:55:25 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:55:25 INFO - 2017-01-14 04:55:25.392 screenresolution[2014:15821] starting screenresolution argv=screenresolution get 04:55:25 INFO - 2017-01-14 04:55:25.395 screenresolution[2014:15821] Display 0: 1600x1200x32@60 04:55:25 INFO - 2017-01-14 04:55:25.401 screenresolution[2015:15824] starting screenresolution argv=screenresolution list 04:55:25 INFO - Available Modes on Display 0 04:55:25 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:55:25 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:55:25 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:55:25 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:55:25 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:55:25 INFO - Intel Iris: 04:55:25 INFO - Chipset Model: Intel Iris 04:55:25 INFO - Type: GPU 04:55:25 INFO - Bus: Built-In 04:55:25 INFO - VRAM (Dynamic, Max): 1536 MB 04:55:25 INFO - Vendor: Intel (0x8086) 04:55:25 INFO - Device ID: 0x0a2e 04:55:25 INFO - Revision ID: 0x0009 04:55:25 INFO - Displays: 04:55:25 INFO - Display: 04:55:25 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:55:25 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:55:25 INFO - Display Serial Number: 1600x1200 60 04:55:25 INFO - Main Display: Yes 04:55:25 INFO - Mirror: Off 04:55:25 INFO - Online: Yes 04:55:25 INFO - Rotation: Supported 04:55:25 INFO - Return code: 0 04:55:25 INFO - Running post-action listener: _resource_record_post_action 04:55:25 INFO - [mozharness: 2017-01-14 12:55:25.639260Z] Finished run-tests step (success) 04:55:25 INFO - Running post-run listener: _resource_record_post_run 04:55:25 INFO - Total resource usage - Wall time: 1201s; CPU: 54.0%; Read bytes: 270336; Write bytes: 554329088; Read time: 6; Write time: 1744 04:55:25 INFO - TinderboxPrint: CPU usage
53.8% 04:55:25 INFO - TinderboxPrint: I/O read bytes / time
270,336 / 6 04:55:25 INFO - TinderboxPrint: I/O write bytes / time
554,329,088 / 1,744 04:55:25 INFO - TinderboxPrint: CPU idle
2,220.5 (46.2%) 04:55:25 INFO - TinderboxPrint: CPU system
958.6 (19.9%) 04:55:25 INFO - TinderboxPrint: CPU user
1,626.7 (33.8%) 04:55:25 INFO - TinderboxPrint: Swap in / out
250,970,112 / 0 04:55:25 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 8192; Write bytes: 252268544; Read time: 1; Write time: 476 04:55:25 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 106496; Write bytes: 300528640; Read time: 2; Write time: 1261 04:55:26 INFO - Running post-run listener: _upload_blobber_files 04:55:26 INFO - Blob upload gear active. 04:55:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:55:26 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:55:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:55:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:55:26 INFO - (blobuploader) - INFO - Open directory for files ... 04:55:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:55:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:55:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:55:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:55:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:55:28 INFO - (blobuploader) - INFO - Done attempting. 04:55:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:55:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:55:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:55:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:55:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:55:29 INFO - (blobuploader) - INFO - Done attempting. 04:55:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:55:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:55:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:55:30 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:55:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:55:30 INFO - (blobuploader) - INFO - Done attempting. 04:55:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:55:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:55:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:55:32 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:55:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:55:32 INFO - (blobuploader) - INFO - Done attempting. 04:55:32 INFO - (blobuploader) - INFO - Iteration through files over. 04:55:32 INFO - Return code: 0 04:55:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:55:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:55:32 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/449a481d80b40cd7413a331bc841c6d100b3c2b798d1327c80410217b6fd029daab753abab2eccbe882d62d08c14bdd4c343a290d695eb46e6a8a92710e14eaa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4c5f8396386697fdd64c3bd051209e0c090b4958626bdbcd7b2ba96e2f3c25b70f5e4cb37a970d391251078800bb4048e6f29b4e7ca0bcf47f8a4b1efab7efbc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/974a4c1dfe6669aa33b309f56fc2e919dbea8db874da71f752e9e61415df0e775507ee96fa7100eb71d064ce8f4a45fe3d6dc80ca43e10c41b464fcbdd5b489a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d5027beb50f57f6d1638132f52569728e16943da961112605a98c4ca2aca921479ad016658a157af2e5859206a0625e8c5f965a498b4f44184b070f7b4489ae1"} 04:55:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:55:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:55:32 INFO - Contents: 04:55:32 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/449a481d80b40cd7413a331bc841c6d100b3c2b798d1327c80410217b6fd029daab753abab2eccbe882d62d08c14bdd4c343a290d695eb46e6a8a92710e14eaa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4c5f8396386697fdd64c3bd051209e0c090b4958626bdbcd7b2ba96e2f3c25b70f5e4cb37a970d391251078800bb4048e6f29b4e7ca0bcf47f8a4b1efab7efbc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/974a4c1dfe6669aa33b309f56fc2e919dbea8db874da71f752e9e61415df0e775507ee96fa7100eb71d064ce8f4a45fe3d6dc80ca43e10c41b464fcbdd5b489a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d5027beb50f57f6d1638132f52569728e16943da961112605a98c4ca2aca921479ad016658a157af2e5859206a0625e8c5f965a498b4f44184b070f7b4489ae1"} 04:55:32 INFO - Running post-run listener: copy_logs_to_upload_dir 04:55:32 INFO - Copying logs to upload dir... 04:55:32 INFO - mkdir: /builds/slave/test/build/upload/logs 04:55:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1516.221737 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 25 mins, 16 secs) (at 2017-01-14 04:55:32.632232) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-14 04:55:32.635805) ========= 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.8phl2DXfk2/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.2oCsQKvJYP/Listeners TMPDIR=/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/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/449a481d80b40cd7413a331bc841c6d100b3c2b798d1327c80410217b6fd029daab753abab2eccbe882d62d08c14bdd4c343a290d695eb46e6a8a92710e14eaa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4c5f8396386697fdd64c3bd051209e0c090b4958626bdbcd7b2ba96e2f3c25b70f5e4cb37a970d391251078800bb4048e6f29b4e7ca0bcf47f8a4b1efab7efbc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/974a4c1dfe6669aa33b309f56fc2e919dbea8db874da71f752e9e61415df0e775507ee96fa7100eb71d064ce8f4a45fe3d6dc80ca43e10c41b464fcbdd5b489a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d5027beb50f57f6d1638132f52569728e16943da961112605a98c4ca2aca921479ad016658a157af2e5859206a0625e8c5f965a498b4f44184b070f7b4489ae1"} build_url:https://queue.taskcluster.net/v1/task/LhNaBhW-T7-leuif4HywFg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010982 build_url: 'https://queue.taskcluster.net/v1/task/LhNaBhW-T7-leuif4HywFg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/449a481d80b40cd7413a331bc841c6d100b3c2b798d1327c80410217b6fd029daab753abab2eccbe882d62d08c14bdd4c343a290d695eb46e6a8a92710e14eaa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4c5f8396386697fdd64c3bd051209e0c090b4958626bdbcd7b2ba96e2f3c25b70f5e4cb37a970d391251078800bb4048e6f29b4e7ca0bcf47f8a4b1efab7efbc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/974a4c1dfe6669aa33b309f56fc2e919dbea8db874da71f752e9e61415df0e775507ee96fa7100eb71d064ce8f4a45fe3d6dc80ca43e10c41b464fcbdd5b489a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d5027beb50f57f6d1638132f52569728e16943da961112605a98c4ca2aca921479ad016658a157af2e5859206a0625e8c5f965a498b4f44184b070f7b4489ae1"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-14 04:55:32.669216) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-14 04:55:32.669553) ========= 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.8phl2DXfk2/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.2oCsQKvJYP/Listeners TMPDIR=/var/folders/72/tvk_0qk91l1gsxjmnd64n0bm00000w/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.005234 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-14 04:55:32.718316) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-14 04:55:32.718645) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-14 04:55:32.718981) ========= ========= Total master_lag: 0.19 =========