builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0159 starttime: 1490355938.38 results: success (0) buildid: 20170324030205 builduid: aa58b96c20034885814ad3762347cb27 revision: 01d1dedf400d4be413b1a0d48090dca7acf29637 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-24 04:45:38.380460) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-24 04:45:38.381175) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-24 04:45:38.381657) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-24 04:45:38.411625) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-24 04:45:38.412233) ========= 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.B1iZRk8pAA/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.Ao87O9fdqL/Listeners TMPDIR=/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-03-24 04:45:38-- 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% 13.9M=0.001s 2017-03-24 04:45:38 (13.9 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.493746 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-24 04:45:38.934548) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-24 04:45:38.935348) ========= 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.B1iZRk8pAA/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.Ao87O9fdqL/Listeners TMPDIR=/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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.029600 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-24 04:45:39.032794) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-24 04:45:39.033138) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 01d1dedf400d4be413b1a0d48090dca7acf29637 --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 01d1dedf400d4be413b1a0d48090dca7acf29637 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.B1iZRk8pAA/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.Ao87O9fdqL/Listeners TMPDIR=/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-03-24 04:45:39,135 truncating revision to first 12 chars 2017-03-24 04:45:39,135 Setting DEBUG logging. 2017-03-24 04:45:39,135 attempt 1/10 2017-03-24 04:45:39,135 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/01d1dedf400d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-24 04:45:39,450 unpacking tar archive at: mozilla-central-01d1dedf400d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.633691 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-24 04:45:39.692275) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-24 04:45:39.692911) ========= script_repo_revision: 01d1dedf400d4be413b1a0d48090dca7acf29637 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-24 04:45:39.693870) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-24 04:45:39.694548) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-24 04:45:39.749348) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 31 secs) (at 2017-03-24 04:45:39.749712) ========= /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.B1iZRk8pAA/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.Ao87O9fdqL/Listeners TMPDIR=/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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:45:39 INFO - MultiFileLogger online at 20170324 04:45:39 in /builds/slave/test 04:45:39 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:45:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:45:39 INFO - {'append_to_log': False, 04:45:39 INFO - 'base_work_dir': '/builds/slave/test', 04:45:39 INFO - 'blob_upload_branch': 'Firefox', 04:45:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:45:39 INFO - 'branch': 'Firefox', 04:45:39 INFO - 'buildbot_json_path': 'buildprops.json', 04:45:39 INFO - 'config_files': ('talos/mac_config.py',), 04:45:39 INFO - 'default_actions': ('clobber', 04:45:39 INFO - 'read-buildbot-config', 04:45:39 INFO - 'download-and-extract', 04:45:39 INFO - 'populate-webroot', 04:45:39 INFO - 'create-virtualenv', 04:45:39 INFO - 'install', 04:45:39 INFO - 'run-tests'), 04:45:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:45:39 INFO - 'download_minidump_stackwalk': True, 04:45:39 INFO - 'download_symbols': 'ondemand', 04:45:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:45:39 INFO - 'tooltool.py': '/tools/tooltool.py', 04:45:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:45:39 INFO - '/tools/misc-python/virtualenv.py')}, 04:45:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:45:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:45:39 INFO - 'gecko_profile': False, 04:45:39 INFO - 'gecko_profile_interval': 0, 04:45:39 INFO - 'installer_path': 'installer.exe', 04:45:39 INFO - 'log_level': 'info', 04:45:39 INFO - 'log_name': 'talos', 04:45:39 INFO - 'log_to_console': True, 04:45:39 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:45:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:45:39 INFO - 'opt_config_files': (), 04:45:39 INFO - 'pip_index': False, 04:45:39 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:45:39 INFO - 'cmd': ('bash', 04:45:39 INFO - '-c', 04:45:39 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:45:39 INFO - 'enabled': True, 04:45:39 INFO - 'halt_on_failure': False, 04:45:39 INFO - 'name': 'check_screen_resolution'},), 04:45:39 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:45:39 INFO - 'cmd': ('bash', 04:45:39 INFO - '-c', 04:45:39 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:45:39 INFO - 'enabled': True, 04:45:39 INFO - 'halt_on_failure': False, 04:45:39 INFO - 'name': 'check_screen_resolution'},), 04:45:39 INFO - 'run_cmd_checks_enabled': True, 04:45:39 INFO - 'suite': 'dromaeojs', 04:45:39 INFO - 'system_bits': '32', 04:45:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:45:39 INFO - 'title': 't-yosemite-r7-0159', 04:45:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:45:39 INFO - 'use_talos_json': True, 04:45:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:45:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:45:39 INFO - 'work_dir': 'build'} 04:45:39 INFO - [mozharness: 2017-03-24 11:45:39.965598Z] Running clobber step. 04:45:39 INFO - Running pre-action listener: _resource_record_pre_action 04:45:39 INFO - Running main action method: clobber 04:45:39 INFO - rmtree: /builds/slave/test/build 04:45:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:45:42 INFO - Running post-action listener: _resource_record_post_action 04:45:42 INFO - [mozharness: 2017-03-24 11:45:42.614693Z] Finished clobber step (success) 04:45:42 INFO - [mozharness: 2017-03-24 11:45:42.614826Z] Running read-buildbot-config step. 04:45:42 INFO - Running pre-action listener: _resource_record_pre_action 04:45:42 INFO - Running main action method: read_buildbot_config 04:45:42 INFO - Using buildbot properties: 04:45:42 INFO - { 04:45:42 INFO - "project": "", 04:45:42 INFO - "product": "firefox", 04:45:42 INFO - "script_repo_revision": "production", 04:45:42 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 04:45:42 INFO - "repository": "", 04:45:42 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 04:45:42 INFO - "buildid": "20170324030205", 04:45:42 INFO - "stage_platform": "macosx64", 04:45:42 INFO - "basedir": "/builds/slave/test", 04:45:42 INFO - "nightly_build": "True", 04:45:42 INFO - "buildnumber": 10, 04:45:42 INFO - "slavename": "t-yosemite-r7-0159", 04:45:42 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 04:45:42 INFO - "platform": "yosemite_r7", 04:45:42 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:45:42 INFO - "branch": "mozilla-central", 04:45:42 INFO - "repo_path": "mozilla-central", 04:45:42 INFO - "revision": "01d1dedf400d4be413b1a0d48090dca7acf29637", 04:45:42 INFO - "pgo_build": "False", 04:45:42 INFO - "builduid": "aa58b96c20034885814ad3762347cb27", 04:45:42 INFO - "slavebuilddir": "test" 04:45:42 INFO - } 04:45:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/bQuINYnKTCaU9c-GxfxzMA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 04:45:42 INFO - Running post-action listener: _resource_record_post_action 04:45:42 INFO - [mozharness: 2017-03-24 11:45:42.618273Z] Finished read-buildbot-config step (success) 04:45:42 INFO - [mozharness: 2017-03-24 11:45:42.618396Z] Running download-and-extract step. 04:45:42 INFO - Running pre-action listener: _resource_record_pre_action 04:45:42 INFO - Running main action method: download_and_extract 04:45:42 INFO - mkdir: /builds/slave/test/build/tests 04:45:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:45:42 INFO - trying https://queue.taskcluster.net/v1/task/bQuINYnKTCaU9c-GxfxzMA/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 04:45:42 INFO - Downloading https://queue.taskcluster.net/v1/task/bQuINYnKTCaU9c-GxfxzMA/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 04:45:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bQuINYnKTCaU9c-GxfxzMA/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 04:45:43 INFO - Downloaded 1325 bytes. 04:45:43 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 04:45:43 INFO - Using the following test package requirements: 04:45:43 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:45:43 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 04:45:43 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 04:45:43 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:45:43 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 04:45:43 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:45:43 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 04:45:43 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:45:43 INFO - u'jsshell-mac.zip'], 04:45:43 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:45:43 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 04:45:43 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 04:45:43 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:45:43 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 04:45:43 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:45:43 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 04:45:43 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:45:43 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 04:45:43 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:45:43 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 04:45:43 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:45:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bQuINYnKTCaU9c-GxfxzMA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 04:45:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bQuINYnKTCaU9c-GxfxzMA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:45:43 INFO - Fetch https://queue.taskcluster.net/v1/task/bQuINYnKTCaU9c-GxfxzMA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 04:45:46 INFO - Expected file size: 52406760 04:45:46 INFO - Obtained file size: 52406760 04:46:02 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:46:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bQuINYnKTCaU9c-GxfxzMA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 04:46:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bQuINYnKTCaU9c-GxfxzMA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:46:02 INFO - Fetch https://queue.taskcluster.net/v1/task/bQuINYnKTCaU9c-GxfxzMA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 04:46:05 INFO - Expected file size: 52406760 04:46:05 INFO - Obtained file size: 52406760 04:46:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bQuINYnKTCaU9c-GxfxzMA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 04:46:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bQuINYnKTCaU9c-GxfxzMA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:46:20 INFO - Fetch https://queue.taskcluster.net/v1/task/bQuINYnKTCaU9c-GxfxzMA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 04:46:22 INFO - Expected file size: 14404171 04:46:22 INFO - Obtained file size: 14404171 04:46: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:46:22 INFO - trying https://queue.taskcluster.net/v1/task/bQuINYnKTCaU9c-GxfxzMA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:46:22 INFO - Downloading https://queue.taskcluster.net/v1/task/bQuINYnKTCaU9c-GxfxzMA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 04:46:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bQuINYnKTCaU9c-GxfxzMA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 04:46:24 INFO - Downloaded 75537540 bytes. 04:46:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bQuINYnKTCaU9c-GxfxzMA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:46:24 INFO - mkdir: /builds/slave/test/properties 04:46:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:46:24 INFO - Writing to file /builds/slave/test/properties/build_url 04:46:24 INFO - Contents: 04:46:24 INFO - build_url:https://queue.taskcluster.net/v1/task/bQuINYnKTCaU9c-GxfxzMA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:46:25 INFO - Running post-action listener: _resource_record_post_action 04:46:25 INFO - Running post-action listener: set_extra_try_arguments 04:46:25 INFO - [mozharness: 2017-03-24 11:46:25.279915Z] Finished download-and-extract step (success) 04:46:25 INFO - [mozharness: 2017-03-24 11:46:25.280039Z] Running populate-webroot step. 04:46:25 INFO - Running pre-action listener: _resource_record_pre_action 04:46:25 INFO - Running main action method: populate_webroot 04:46:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:46:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:46:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:46:25 INFO - '--tppagecycles', 04:46:25 INFO - '7'], 04:46:25 INFO - 'tests': ['tsvgm']}}, 04:46:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:46:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:46:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:46:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:46:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:46:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:46:25 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:46:25 INFO - 'talos_options': ['--disable-e10s'], 04:46:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:46:25 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:46:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:46:25 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:46:25 INFO - 'talos_options': ['--disable-e10s'], 04:46:25 INFO - 'tests': ['damp', 'tps']}, 04:46:25 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:46:25 INFO - 'tests': ['damp', 'tps']}, 04:46:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:46:25 INFO - 'tests': ['dromaeo_dom']}, 04:46:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:46:25 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:46:25 INFO - 'tests': ['basic_compositor_video']}, 04:46:25 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:46:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:46:25 INFO - 'tests': ['a11yr', 04:46:25 INFO - 'ts_paint', 04:46:25 INFO - 'tpaint', 04:46:25 INFO - 'sessionrestore', 04:46:25 INFO - 'sessionrestore_no_auto_restore', 04:46:25 INFO - 'tabpaint']}, 04:46:25 INFO - 'other-e10s': {'tests': ['a11yr', 04:46:25 INFO - 'ts_paint', 04:46:25 INFO - 'tpaint', 04:46:25 INFO - 'sessionrestore', 04:46:25 INFO - 'sessionrestore_no_auto_restore', 04:46:25 INFO - 'tabpaint']}, 04:46:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:46:25 INFO - 'ts_paint', 04:46:25 INFO - 'tpaint', 04:46:25 INFO - 'sessionrestore', 04:46:25 INFO - 'sessionrestore_no_auto_restore', 04:46:25 INFO - 'tabpaint']}, 04:46:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:46:25 INFO - 'ts_paint', 04:46:25 INFO - 'tpaint', 04:46:25 INFO - 'sessionrestore', 04:46:25 INFO - 'sessionrestore_no_auto_restore', 04:46:25 INFO - 'tabpaint']}, 04:46:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:46:25 INFO - 'tests': ['a11yr', 04:46:25 INFO - 'ts_paint', 04:46:25 INFO - 'tpaint', 04:46:25 INFO - 'sessionrestore', 04:46:25 INFO - 'sessionrestore_no_auto_restore', 04:46:25 INFO - 'tabpaint']}, 04:46:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:46:25 INFO - 'tests': ['a11yr', 04:46:25 INFO - 'ts_paint', 04:46:25 INFO - 'tpaint', 04:46:25 INFO - 'sessionrestore', 04:46:25 INFO - 'sessionrestore_no_auto_restore', 04:46:25 INFO - 'tabpaint']}, 04:46:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:46:25 INFO - 'tests': ['tsvgx', 04:46:25 INFO - 'tsvgr_opacity', 04:46:25 INFO - 'tart', 04:46:25 INFO - 'tscrollx', 04:46:25 INFO - 'cart', 04:46:25 INFO - 'tsvg_static']}, 04:46:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:46:25 INFO - 'tsvgr_opacity', 04:46:25 INFO - 'tart', 04:46:25 INFO - 'tscrollx', 04:46:25 INFO - 'cart', 04:46:25 INFO - 'tsvg_static']}, 04:46:25 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:46:25 INFO - 'talos_options': ['--disable-e10s'], 04:46:25 INFO - 'tests': ['tp5o']}, 04:46:25 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:46:25 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:46:25 INFO - 'talos_options': ['--disable-e10s', 04:46:25 INFO - '--xperf_path', 04:46:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:46:25 INFO - 'tests': ['tp5n']}, 04:46:25 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:46:25 INFO - 'talos_options': ['--xperf_path', 04:46:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:46:25 INFO - 'tests': ['tp5n']}}, 04:46:25 INFO - 'talos.zip': {'path': '', 04:46:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:46:25 INFO - Running post-action listener: _resource_record_post_action 04:46:25 INFO - [mozharness: 2017-03-24 11:46:25.298672Z] Finished populate-webroot step (success) 04:46:25 INFO - [mozharness: 2017-03-24 11:46:25.298807Z] Running create-virtualenv step. 04:46:25 INFO - Running pre-action listener: _resource_record_pre_action 04:46:25 INFO - Running main action method: create_virtualenv 04:46:25 INFO - Creating virtualenv /builds/slave/test/build/venv 04:46:25 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:46:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:46:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:46:25 INFO - Using real prefix '/tools/python27' 04:46:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:46:26 INFO - Installing distribute.............................................................................................................................................................................................done. 04:46:29 INFO - Installing pip.................done. 04:46:29 INFO - Return code: 0 04:46:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:46:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:46:29 INFO - Reading from file tmpfile_stdout 04:46:29 INFO - Output received: 04:46:29 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:46:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:46:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:46:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:46:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:29 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 0x10c59fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c5a2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f29489b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c37dd30>, '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 0x10c2a4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c372be8>, '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.B1iZRk8pAA/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.Ao87O9fdqL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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:46:29 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:46:29 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:46:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.B1iZRk8pAA/Render', 04:46:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:46:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:46:29 INFO - 'HOME': '/Users/cltbld', 04:46:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:46:29 INFO - 'LOGNAME': 'cltbld', 04:46:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:29 INFO - 'MOZ_NO_REMOTE': '1', 04:46:29 INFO - 'NO_EM_RESTART': '1', 04:46:29 INFO - 'PAGER': '/bin/cat', 04:46:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:46:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:29 INFO - 'PWD': '/builds/slave/test', 04:46:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:46:29 INFO - 'SHELL': '/bin/bash', 04:46:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ao87O9fdqL/Listeners', 04:46:29 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 04:46:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:46:29 INFO - 'USER': 'cltbld', 04:46:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:46:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:46:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:29 INFO - 'XPC_FLAGS': '0x0', 04:46:29 INFO - 'XPC_SERVICE_NAME': '0', 04:46:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:46:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:29 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:46:29 INFO - Cleaning up... 04:46:29 INFO - Return code: 0 04:46:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:46:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:46:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:46:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:29 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 0x10c59fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c5a2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f29489b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c37dd30>, '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 0x10c2a4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c372be8>, '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.B1iZRk8pAA/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.Ao87O9fdqL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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:46:29 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:46:29 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:46:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.B1iZRk8pAA/Render', 04:46:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:46:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:46:29 INFO - 'HOME': '/Users/cltbld', 04:46:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:46:29 INFO - 'LOGNAME': 'cltbld', 04:46:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:29 INFO - 'MOZ_NO_REMOTE': '1', 04:46:29 INFO - 'NO_EM_RESTART': '1', 04:46:29 INFO - 'PAGER': '/bin/cat', 04:46:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:46:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:29 INFO - 'PWD': '/builds/slave/test', 04:46:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:46:29 INFO - 'SHELL': '/bin/bash', 04:46:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ao87O9fdqL/Listeners', 04:46:29 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 04:46:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:46:29 INFO - 'USER': 'cltbld', 04:46:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:46:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:46:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:29 INFO - 'XPC_FLAGS': '0x0', 04:46:29 INFO - 'XPC_SERVICE_NAME': '0', 04:46:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:46:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:29 INFO - Downloading/unpacking psutil>=3.1.1 04:46:29 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:46:29 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:46:29 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:46:29 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:46:29 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:46:29 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:46:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:46:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:46:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:46:34 INFO - Installing collected packages: psutil 04:46:34 INFO - Running setup.py install for psutil 04:46:34 INFO - building 'psutil._psutil_osx' extension 04:46:34 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:46:34 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:46:34 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:46:34 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:46:34 INFO - building 'psutil._psutil_posix' extension 04:46:34 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:46:34 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:46:34 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:46:34 INFO - ^ 04:46:35 INFO - 1 warning generated. 04:46:35 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:46:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:46:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:46:35 INFO - Successfully installed psutil 04:46:35 INFO - Cleaning up... 04:46:35 INFO - Return code: 0 04:46:35 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:46:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:46:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:46:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:35 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 0x10c59fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c5a2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f29489b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c37dd30>, '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 0x10c2a4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c372be8>, '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.B1iZRk8pAA/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.Ao87O9fdqL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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:46:35 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:46:35 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:46:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.B1iZRk8pAA/Render', 04:46:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:46:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:46:35 INFO - 'HOME': '/Users/cltbld', 04:46:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:46:35 INFO - 'LOGNAME': 'cltbld', 04:46:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:35 INFO - 'MOZ_NO_REMOTE': '1', 04:46:35 INFO - 'NO_EM_RESTART': '1', 04:46:35 INFO - 'PAGER': '/bin/cat', 04:46:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:46:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:35 INFO - 'PWD': '/builds/slave/test', 04:46:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:46:35 INFO - 'SHELL': '/bin/bash', 04:46:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ao87O9fdqL/Listeners', 04:46:35 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 04:46:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:46:35 INFO - 'USER': 'cltbld', 04:46:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:46:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:46:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:35 INFO - 'XPC_FLAGS': '0x0', 04:46:35 INFO - 'XPC_SERVICE_NAME': '0', 04:46:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:46:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:35 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:46:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:38 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:46:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:46:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:46:38 INFO - Installing collected packages: mozsystemmonitor 04:46:38 INFO - Running setup.py install for mozsystemmonitor 04:46:38 INFO - Successfully installed mozsystemmonitor 04:46:38 INFO - Cleaning up... 04:46:38 INFO - Return code: 0 04:46:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:46:38 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:46:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:38 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:46:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:38 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 0x10c59fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c5a2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f29489b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c37dd30>, '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 0x10c2a4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c372be8>, '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.B1iZRk8pAA/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.Ao87O9fdqL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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:46:38 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:46:38 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:46:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.B1iZRk8pAA/Render', 04:46:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:46:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:46:38 INFO - 'HOME': '/Users/cltbld', 04:46:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:46:38 INFO - 'LOGNAME': 'cltbld', 04:46:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:38 INFO - 'MOZ_NO_REMOTE': '1', 04:46:38 INFO - 'NO_EM_RESTART': '1', 04:46:38 INFO - 'PAGER': '/bin/cat', 04:46:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:46:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:38 INFO - 'PWD': '/builds/slave/test', 04:46:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:46:38 INFO - 'SHELL': '/bin/bash', 04:46:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ao87O9fdqL/Listeners', 04:46:38 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 04:46:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:46:38 INFO - 'USER': 'cltbld', 04:46:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:46:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:46:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:38 INFO - 'XPC_FLAGS': '0x0', 04:46:38 INFO - 'XPC_SERVICE_NAME': '0', 04:46:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:46:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:38 INFO - Downloading/unpacking jsonschema==2.5.1 04:46:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:46:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:46:41 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:46:41 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:46:41 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:46:41 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:46:41 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:46:41 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:46:41 INFO - Downloading functools32-3.2.3-2.tar.gz 04:46:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:46:41 INFO - warning: no files found matching '*.txt' 04:46:41 INFO - no previously-included directories found matching 'build' 04:46:41 INFO - no previously-included directories found matching 'dist' 04:46:41 INFO - no previously-included directories found matching '.git*' 04:46:41 INFO - Installing collected packages: jsonschema, functools32 04:46:41 INFO - Running setup.py install for functools32 04:46:42 INFO - warning: no files found matching '*.txt' 04:46:42 INFO - no previously-included directories found matching 'build' 04:46:42 INFO - no previously-included directories found matching 'dist' 04:46:42 INFO - no previously-included directories found matching '.git*' 04:46:42 INFO - Successfully installed jsonschema functools32 04:46:42 INFO - Cleaning up... 04:46:42 INFO - Return code: 0 04:46:42 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:46:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:46:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:46:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:42 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 0x10c59fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c5a2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f29489b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c37dd30>, '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 0x10c2a4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c372be8>, '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.B1iZRk8pAA/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.Ao87O9fdqL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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:46:42 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:46:42 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:46:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.B1iZRk8pAA/Render', 04:46:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:46:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:46:42 INFO - 'HOME': '/Users/cltbld', 04:46:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:46:42 INFO - 'LOGNAME': 'cltbld', 04:46:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:42 INFO - 'MOZ_NO_REMOTE': '1', 04:46:42 INFO - 'NO_EM_RESTART': '1', 04:46:42 INFO - 'PAGER': '/bin/cat', 04:46:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:46:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:42 INFO - 'PWD': '/builds/slave/test', 04:46:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:46:42 INFO - 'SHELL': '/bin/bash', 04:46:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ao87O9fdqL/Listeners', 04:46:42 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 04:46:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:46:42 INFO - 'USER': 'cltbld', 04:46:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:46:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:46:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:42 INFO - 'XPC_FLAGS': '0x0', 04:46:42 INFO - 'XPC_SERVICE_NAME': '0', 04:46:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:46:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:42 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:46:42 INFO - Cleaning up... 04:46:42 INFO - Return code: 0 04:46:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:46:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:46:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:46:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:42 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 0x10c59fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c5a2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f29489b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c37dd30>, '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 0x10c2a4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c372be8>, '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.B1iZRk8pAA/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.Ao87O9fdqL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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:46:42 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:46:42 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:46:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.B1iZRk8pAA/Render', 04:46:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:46:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:46:42 INFO - 'HOME': '/Users/cltbld', 04:46:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:46:42 INFO - 'LOGNAME': 'cltbld', 04:46:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:42 INFO - 'MOZ_NO_REMOTE': '1', 04:46:42 INFO - 'NO_EM_RESTART': '1', 04:46:42 INFO - 'PAGER': '/bin/cat', 04:46:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:46:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:42 INFO - 'PWD': '/builds/slave/test', 04:46:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:46:42 INFO - 'SHELL': '/bin/bash', 04:46:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ao87O9fdqL/Listeners', 04:46:42 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 04:46:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:46:42 INFO - 'USER': 'cltbld', 04:46:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:46:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:46:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:42 INFO - 'XPC_FLAGS': '0x0', 04:46:42 INFO - 'XPC_SERVICE_NAME': '0', 04:46:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:46:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:42 INFO - Downloading/unpacking blobuploader==1.2.4 04:46:42 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:46:42 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:46:42 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:46:42 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:46:42 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:46:42 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:46:45 INFO - Downloading blobuploader-1.2.4.tar.gz 04:46:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:46:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:46:45 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:46:45 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:46:45 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:46:45 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:46:45 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:46:45 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:46:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:46:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:46:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:46 INFO - Downloading docopt-0.6.1.tar.gz 04:46:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:46:46 INFO - Installing collected packages: blobuploader, requests, docopt 04:46:46 INFO - Running setup.py install for blobuploader 04:46:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:46:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:46:46 INFO - Running setup.py install for requests 04:46:47 INFO - Running setup.py install for docopt 04:46:47 INFO - Successfully installed blobuploader requests docopt 04:46:47 INFO - Cleaning up... 04:46:47 INFO - Return code: 0 04:46:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:46:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:46:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:46:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:47 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 0x10c59fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c5a2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f29489b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c37dd30>, '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 0x10c2a4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c372be8>, '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.B1iZRk8pAA/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.Ao87O9fdqL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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:46:47 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:46:47 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:46:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.B1iZRk8pAA/Render', 04:46:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:46:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:46:47 INFO - 'HOME': '/Users/cltbld', 04:46:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:46:47 INFO - 'LOGNAME': 'cltbld', 04:46:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:47 INFO - 'MOZ_NO_REMOTE': '1', 04:46:47 INFO - 'NO_EM_RESTART': '1', 04:46:47 INFO - 'PAGER': '/bin/cat', 04:46:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:46:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:47 INFO - 'PWD': '/builds/slave/test', 04:46:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:46:47 INFO - 'SHELL': '/bin/bash', 04:46:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ao87O9fdqL/Listeners', 04:46:47 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 04:46:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:46:47 INFO - 'USER': 'cltbld', 04:46:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:46:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:46:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:47 INFO - 'XPC_FLAGS': '0x0', 04:46:47 INFO - 'XPC_SERVICE_NAME': '0', 04:46:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:46:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:46:47 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-raHVTy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:46:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:46:47 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-SHyynY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:46:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:46:48 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-x5dVfT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:46:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:46:48 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-PlROP0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:46:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:46:48 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-t9g_GY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:46:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:46:48 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-vhzOcr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:46:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:46:48 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-gMvZ18-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:46:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:46:48 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-v7yG6g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:46:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:46:48 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-ljKgMn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:46:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:46:48 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-NVidOU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:46:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:46:48 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-OPUn7m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:46:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:46:49 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-IOBNjy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:46:49 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-tyQ5yX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:46:49 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-eMJ_b6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:46:49 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-6sCZil-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:46:49 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-9i55e5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:46:49 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-m0IdsR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:46:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:46:49 INFO - Running setup.py install for manifestparser 04:46:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:46:49 INFO - Running setup.py install for mozcrash 04:46:49 INFO - Running setup.py install for mozdebug 04:46:50 INFO - Running setup.py install for mozdevice 04:46:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:46:50 INFO - Running setup.py install for mozfile 04:46:50 INFO - Running setup.py install for mozhttpd 04:46:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:46:50 INFO - Running setup.py install for mozinfo 04:46:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:46:50 INFO - Running setup.py install for mozInstall 04:46:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:46:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:46:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:46:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:46:50 INFO - Running setup.py install for mozleak 04:46:50 INFO - Running setup.py install for mozlog 04:46:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:46:51 INFO - Running setup.py install for moznetwork 04:46:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:46:51 INFO - Running setup.py install for mozprocess 04:46:51 INFO - Running setup.py install for mozprofile 04:46:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:46:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:46:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:46:51 INFO - Running setup.py install for mozrunner 04:46:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:46:51 INFO - Running setup.py install for mozscreenshot 04:46:51 INFO - Running setup.py install for moztest 04:46:52 INFO - Running setup.py install for mozversion 04:46:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:46:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:46:52 INFO - Cleaning up... 04:46:52 INFO - Return code: 0 04:46:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:46:52 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:46:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:52 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:46:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:52 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 0x10c59fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c5a2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f29489b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c37dd30>, '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 0x10c2a4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c372be8>, '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.B1iZRk8pAA/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.Ao87O9fdqL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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:46:52 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:46:52 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:46:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.B1iZRk8pAA/Render', 04:46:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:46:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:46:52 INFO - 'HOME': '/Users/cltbld', 04:46:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:46:52 INFO - 'LOGNAME': 'cltbld', 04:46:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:52 INFO - 'MOZ_NO_REMOTE': '1', 04:46:52 INFO - 'NO_EM_RESTART': '1', 04:46:52 INFO - 'PAGER': '/bin/cat', 04:46:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:46:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:52 INFO - 'PWD': '/builds/slave/test', 04:46:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:46:52 INFO - 'SHELL': '/bin/bash', 04:46:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ao87O9fdqL/Listeners', 04:46:52 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 04:46:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:46:52 INFO - 'USER': 'cltbld', 04:46:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:46:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:46:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:52 INFO - 'XPC_FLAGS': '0x0', 04:46:52 INFO - 'XPC_SERVICE_NAME': '0', 04:46:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:46:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:46:52 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-HitgJj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:46:52 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:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:46:52 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-avpowd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:46:52 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:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:46:52 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-Tku8Cm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:46:52 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:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:46:52 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-zprc9M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:46:52 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:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:46:52 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-LPxYgb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:46:52 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:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:46:52 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-dLQ0pD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:46:53 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:46:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:46:53 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-Ny_clW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:46:53 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:46:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:46:53 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-opErKV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:46:53 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:46:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:46:53 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-dZVfTS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:46:53 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:46:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:46:53 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-ywpf3Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:46:53 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:46:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:46:53 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-RTfA0_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:46:53 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:46:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:46:53 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-hS07zU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:46:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:46:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:46:53 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-hpWXam-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:46:53 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:46:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:46:53 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-6Sso40-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:46:53 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:46:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:46:53 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-mn6F4e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:46:54 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:46:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:46:54 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-xj8s6X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:46:54 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:46:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:46:54 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-Gz_TXH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:46:54 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:46:54 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:46:54 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:46:54 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:46:54 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:46:54 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:46:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:46: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:46: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:46: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:46: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:46: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:46: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:46:56 INFO - Downloading blessings-1.6.tar.gz 04:46:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:46:56 INFO - Installing collected packages: blessings 04:46:56 INFO - Running setup.py install for blessings 04:46:57 INFO - Successfully installed blessings 04:46:57 INFO - Cleaning up... 04:46:57 INFO - Return code: 0 04:46:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:46:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:46:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:46:57 INFO - Reading from file tmpfile_stdout 04:46:57 INFO - Current package versions: 04:46:57 INFO - blessings == 1.6 04:46:57 INFO - blobuploader == 1.2.4 04:46:57 INFO - docopt == 0.6.1 04:46:57 INFO - functools32 == 3.2.3-2 04:46:57 INFO - jsonschema == 2.5.1 04:46:57 INFO - manifestparser == 1.1 04:46:57 INFO - mozInstall == 1.12 04:46:57 INFO - mozcrash == 1.0 04:46:57 INFO - mozdebug == 0.1 04:46:57 INFO - mozdevice == 0.49 04:46:57 INFO - mozfile == 1.2 04:46:57 INFO - mozhttpd == 0.7 04:46:57 INFO - mozinfo == 0.9 04:46:57 INFO - mozleak == 0.1 04:46:57 INFO - mozlog == 3.4 04:46:57 INFO - moznetwork == 0.27 04:46:57 INFO - mozprocess == 0.25 04:46:57 INFO - mozprofile == 0.28 04:46:57 INFO - mozrunner == 6.13 04:46:57 INFO - mozscreenshot == 0.1 04:46:57 INFO - mozsystemmonitor == 0.3 04:46:57 INFO - moztest == 0.8 04:46:57 INFO - mozversion == 1.4 04:46:57 INFO - psutil == 3.1.1 04:46:57 INFO - requests == 1.2.3 04:46:57 INFO - wsgiref == 0.1.2 04:46:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:46:57 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:46:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:57 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:46:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:57 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 0x10c59fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c5a2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f29489b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c37dd30>, '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 0x10c2a4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c372be8>, '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.B1iZRk8pAA/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.Ao87O9fdqL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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:46:57 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:46:57 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:46:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.B1iZRk8pAA/Render', 04:46:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:46:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:46:57 INFO - 'HOME': '/Users/cltbld', 04:46:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:46:57 INFO - 'LOGNAME': 'cltbld', 04:46:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:57 INFO - 'MOZ_NO_REMOTE': '1', 04:46:57 INFO - 'NO_EM_RESTART': '1', 04:46:57 INFO - 'PAGER': '/bin/cat', 04:46:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:46:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:57 INFO - 'PWD': '/builds/slave/test', 04:46:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:46:57 INFO - 'SHELL': '/bin/bash', 04:46:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ao87O9fdqL/Listeners', 04:46:57 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 04:46:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:46:57 INFO - 'USER': 'cltbld', 04:46:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:46:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:46:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:57 INFO - 'XPC_FLAGS': '0x0', 04:46:57 INFO - 'XPC_SERVICE_NAME': '0', 04:46:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:46:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:57 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:46:57 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:46:57 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:46:57 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:46:57 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:46:57 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:46:57 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:46:57 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:46:57 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:46:57 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:46:57 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:46:57 INFO - Cleaning up... 04:46:57 INFO - Return code: 0 04:46:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:46:57 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:46:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:57 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:46:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:57 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 0x10c59fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c5a2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f29489b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c37dd30>, '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 0x10c2a4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c372be8>, '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.B1iZRk8pAA/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.Ao87O9fdqL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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:46:57 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:46:57 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:46:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.B1iZRk8pAA/Render', 04:46:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:46:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:46:57 INFO - 'HOME': '/Users/cltbld', 04:46:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:46:57 INFO - 'LOGNAME': 'cltbld', 04:46:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:57 INFO - 'MOZ_NO_REMOTE': '1', 04:46:57 INFO - 'NO_EM_RESTART': '1', 04:46:57 INFO - 'PAGER': '/bin/cat', 04:46:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:46:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:57 INFO - 'PWD': '/builds/slave/test', 04:46:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:46:57 INFO - 'SHELL': '/bin/bash', 04:46:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ao87O9fdqL/Listeners', 04:46:57 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 04:46:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:46:57 INFO - 'USER': 'cltbld', 04:46:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:46:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:46:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:57 INFO - 'XPC_FLAGS': '0x0', 04:46:57 INFO - 'XPC_SERVICE_NAME': '0', 04:46:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:46:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:46:58 INFO - Cleaning up... 04:46:58 INFO - Return code: 0 04:46:58 INFO - Running post-action listener: _resource_record_post_action 04:46:58 INFO - Running post-action listener: _start_resource_monitoring 04:46:58 INFO - Starting resource monitoring. 04:46:58 INFO - [mozharness: 2017-03-24 11:46:58.101899Z] Finished create-virtualenv step (success) 04:46:58 INFO - [mozharness: 2017-03-24 11:46:58.102877Z] Running install step. 04:46:58 INFO - Running pre-action listener: _resource_record_pre_action 04:46:58 INFO - Running main action method: install 04:46:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:46:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:46:58 INFO - Reading from file tmpfile_stdout 04:46:58 INFO - Detecting whether we're running mozinstall >=1.0... 04:46:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:46:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:46:58 INFO - Reading from file tmpfile_stdout 04:46:58 INFO - Output received: 04:46:58 INFO - Usage: mozinstall [options] installer 04:46:58 INFO - Options: 04:46:58 INFO - -h, --help show this help message and exit 04:46:58 INFO - -d DEST, --destination=DEST 04:46:58 INFO - Directory to install application into. [default: 04:46:58 INFO - "/builds/slave/test"] 04:46:58 INFO - --app=APP Application being installed. [default: firefox] 04:46:58 INFO - mkdir: /builds/slave/test/build/application 04:46:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:46:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:47:18 INFO - Reading from file tmpfile_stdout 04:47:18 INFO - Output received: 04:47:18 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 04:47:18 INFO - Running post-action listener: _resource_record_post_action 04:47:18 INFO - [mozharness: 2017-03-24 11:47:18.872469Z] Finished install step (success) 04:47:18 INFO - [mozharness: 2017-03-24 11:47:18.872612Z] Running run-tests step. 04:47:18 INFO - Running pre-action listener: _resource_record_pre_action 04:47:18 INFO - Running main action method: run_tests 04:47:18 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:47:18 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:47:18 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:47:18 INFO - 2017-03-24 04:47:18.887 screenresolution[1638:8911] starting screenresolution argv=screenresolution get 04:47:18 INFO - 2017-03-24 04:47:18.889 screenresolution[1638:8911] Display 0: 1600x1200x32@60 04:47:18 INFO - 2017-03-24 04:47:18.895 screenresolution[1639:8913] starting screenresolution argv=screenresolution list 04:47:18 INFO - Available Modes on Display 0 04:47:18 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:47:18 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:47:18 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:47:18 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:47:19 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:47:19 INFO - Intel Iris: 04:47:19 INFO - Chipset Model: Intel Iris 04:47:19 INFO - Type: GPU 04:47:19 INFO - Bus: Built-In 04:47:19 INFO - VRAM (Dynamic, Max): 1536 MB 04:47:19 INFO - Vendor: Intel (0x8086) 04:47:19 INFO - Device ID: 0x0a2e 04:47:19 INFO - Revision ID: 0x0009 04:47:19 INFO - Displays: 04:47:19 INFO - Display: 04:47:19 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:47:19 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:47:19 INFO - Display Serial Number: 1600x1200 60 04:47:19 INFO - Main Display: Yes 04:47:19 INFO - Mirror: Off 04:47:19 INFO - Online: Yes 04:47:19 INFO - Rotation: Supported 04:47:19 INFO - Return code: 0 04:47:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:47:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:47:19 INFO - Python 2.7.3 04:47:19 INFO - Return code: 0 04:47:19 INFO - grabbing minidump binary from tooltool 04:47:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:19 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 0x10c37dd30>, '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 0x10c2a4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c372be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:47:19 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:47:19 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:47:19 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:47:19 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:47:19 INFO - Return code: 0 04:47:19 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:47:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:47:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:47:19 INFO - ENV: RUST_BACKTRACE is now 1 04:47:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:47:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:47:19 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/bQuINYnKTCaU9c-GxfxzMA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0159', '--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:47:19 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/bQuINYnKTCaU9c-GxfxzMA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0159 --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:47:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.B1iZRk8pAA/Render', 04:47:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:47:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:47:19 INFO - 'HOME': '/Users/cltbld', 04:47:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:47:19 INFO - 'LOGNAME': 'cltbld', 04:47:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:47:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:47:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:19 INFO - 'MOZ_NO_REMOTE': '1', 04:47:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:47:19 INFO - 'NO_EM_RESTART': '1', 04:47:19 INFO - 'PAGER': '/bin/cat', 04:47:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:47:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:19 INFO - 'PWD': '/builds/slave/test', 04:47:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:47:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:47:19 INFO - 'RUST_BACKTRACE': '1', 04:47:19 INFO - 'SHELL': '/bin/bash', 04:47:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ao87O9fdqL/Listeners', 04:47:19 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 04:47:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:47:19 INFO - 'USER': 'cltbld', 04:47:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:47:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:47:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:19 INFO - 'XPC_FLAGS': '0x0', 04:47:19 INFO - 'XPC_SERVICE_NAME': '0', 04:47:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:47:19 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/bQuINYnKTCaU9c-GxfxzMA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0159', '--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:47:19 INFO - mozversion application_buildid: 20170324030205 04:47:19 INFO - mozversion application_changeset: 01d1dedf400d4be413b1a0d48090dca7acf29637 04:47:19 INFO - mozversion application_display_name: Nightly 04:47:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:47:19 INFO - mozversion application_name: Firefox 04:47:19 INFO - mozversion application_remotingname: firefox 04:47:19 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:47:19 INFO - mozversion application_vendor: Mozilla 04:47:19 INFO - mozversion application_version: 55.0a1 04:47:19 INFO - mozversion platform_buildid: 20170324030205 04:47:19 INFO - mozversion platform_changeset: 01d1dedf400d4be413b1a0d48090dca7acf29637 04:47:19 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:47:19 INFO - mozversion platform_version: 55.0a1 04:47:19 INFO - using testdate: 1490356039 04:47:19 INFO - actual date: 1490356039 04:47:19 INFO - starting webserver on 'localhost:49243' 04:47:19 INFO - SUITE-START | Running 2 tests 04:47:19 INFO - TEST-START | dromaeo_css 04:47:19 INFO - operating with platform_type : mac_ 04:47:19 INFO - Initialising browser for dromaeo_css test... 04:47:19 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/tmpCf6GjG/profile http://localhost:49243/getInfo.html) 04:47:22 INFO - PID 1649 | __metrics Screen width/height:1600/1200 04:47:22 INFO - PID 1649 | colorDepth:24 04:47:22 INFO - PID 1649 | Browser inner width/height: 1024/689 04:47:22 INFO - PID 1649 | __metrics 04:47:22 INFO - PID 1649 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:47:22 INFO - PID 1649 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:47:23 INFO - TEST-INFO | 1649: exit 0 04:47:23 INFO - Browser initialized. 04:47:23 INFO - Running cycle 1/1 for dromaeo_css test... 04:47:23 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/tmpCf6GjG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:47:35 INFO - PID 1653 | RSS: Main: 233537536 04:47:35 INFO - PID 1653 | 04:50:40 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49243/tests/dromaeo/cssquery-ext.html) 04:50:42 INFO - PID 1653 | RSS: Main: 404996096 04:50:42 INFO - PID 1653 | 04:52:25 INFO - PID 1653 | ************************* 04:52:25 INFO - PID 1653 | A coding exception was thrown and uncaught in a Task. 04:52:25 INFO - PID 1653 | 04:52:25 ERROR - PID 1653 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:52:25 INFO - PID 1653 | Full stack: 04:52:25 INFO - PID 1653 | ************************* 04:53:45 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-ext.html (next: http://localhost:49243/tests/dromaeo/cssquery-jquery.html) 04:53:46 INFO - PID 1653 | RSS: Main: 364826624 04:53:46 INFO - PID 1653 | 04:56:48 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49243/tests/dromaeo/cssquery-mootools.html) 04:56:49 INFO - PID 1653 | RSS: Main: 339456000 04:56:49 INFO - PID 1653 | 04:59:52 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49243/tests/dromaeo/cssquery-prototype.html) 04:59:52 INFO - PID 1653 | RSS: Main: 358481920 04:59:52 INFO - PID 1653 | 05:02:56 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49243/tests/dromaeo/cssquery-yui.html) 05:02:57 INFO - PID 1653 | RSS: Main: 333635584 05:02:57 INFO - PID 1653 | 05:06:00 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-yui.html (next: http://localhost:49243/tests/dromaeo/cssquery-dojo.html) 05:06:01 INFO - PID 1653 | RSS: Main: 373731328 05:06:01 INFO - PID 1653 | 05:06:01 INFO - PID 1653 | __start_tp_report 05:06:01 INFO - PID 1653 | _x_x_mozilla_page_load 05:06:01 INFO - PID 1653 | _x_x_mozilla_page_load_details 05:06:01 INFO - PID 1653 | |i|pagename|runs| 05:06:01 INFO - PID 1653 | |0;dojo.html;3421.298633780075;3441.7934923904554;3444.448888177889;3474.5656792900886;3490.5113284140225;6079.179310793042;6103.359147289531;6118.832384214086;6130.570860039799;6154.230721159861;6078.574499785017;6089.5432842536875;6103.97413805946;6106.816795496131;6124.785632502863;5019.52314530119;5194.194899790529;5446.2375267462585;5471.534919531845;5606.131049687305;5305.230741542474;5526.972365138168;5565.833025009236;5565.9443405566035;5607.074832652607;5414.620976531644;5429.4027656957705;5430.891382172374;5435.130379139358;5444.482774136451;5347.572194224453;5360.731963401853;5373.059714549938;5374.408815030343;5377.650452720561;4714.83498077569;5127.051495473349;5292.994331077083;5350.063738845725;5361;6003.489703375175;6019.097135429677;6029.638221706711;6029.758809647609;6034.24571928509;6318.052292156213;6319.083732858756;6319.494440444753;6323.810285691437;6327.620342779448;6298.811035668938;6317.399847014526;6365.968170159166;6376.936230637681;6457.12828768115;6205.720742566596;6211.130441738115;6241.500679945593;6243.094751261087;6264.812055638338;6676.198856137197;6681.498887583451;6682.198136223684;6696.43080338167;6697.162854643169;5106.872328191751;6116.153172518172;6243.219597550306;6291.182146320949;6291.276503202191;6435.259945106279;6473.126127972663;6478.060681201199;6483.3192514786215;6489.513286503531;6378.362163783585;6388.4569811566535;6395.776147834804;6398;6404.103425520431;6139.952147135068;6208.255009398811;6263.3736626337;6379.744810207632;6411.775587854403;5201.479852014768;5231.032259032091;5248.05535003703;5295.073362161606;5306.681599104066;4607.7004994675235;4619.19164146273;4621.491635920046;4628.190066738307;4669.696469729457;5874.9118763218585;6089.665068421191;6131.601445906002;6137.294211165773;6163.599366041282;6285.308616052231;6298.842528936813;6451.870962580722;6510;6530.183727034121;6150.538709596798;6219.284782250009;6222.284437289679;6229.626222426669;6231.034189700604;5792.768289268466;5798.892032999884;5807.796727114531;5818.0981947798155;5863.853403664943;6321.652309123042;6396.232452105591;6402.775902843378;6597.80206593803;6625.370589793962;6519.869602608016;6550.639714815731;6556.541042127005;6564.868702626016;6565.015247712881;6572.868542629025;6662.233843108104;6666.100076489612;6674.26583075871;6689.2976237496305;6209.472194863307;6426.967865160645;6447.065175549613;6449.097126402214;6449.322821103904;6169.598976066542;6450.193725784277;6475.158229430144;6497.4477169441125;6502.934970650233;6168.167297414791;6244.65654389013;6320.336364681642;6322.841928951813;6329.7151628175925;6148.907766383597;6201.193844800147;6260.248770147429;6278.121063051268;6316.589421687576;6277;6283.277423096402;6288.65412402304;6289.465395441256;6297.779577714758;6203.534734894991;6314.273858506331;6327.050942358683;6339.683015849097;6339.683015849281;6147.0779383092895;6159.384061593805;6159.445649891352;6181.412765787243;6215.751369945152 05:06:01 INFO - PID 1653 | |1;ext.html;711.4486273138318;818.1409520003996;1147.6786499780064;1173.9941300293497;1175.2008634128788;35467.46798798017;36271.2745745085;36271.27457450856;36427;36549.45175822365;40055.59944400555;40189.79430617079;40215.59784402155;40233.19533609326;40266.39600405996;6080.148779170898;6238.906416403757;8560.785980350478;8698.956505217466;8707.042225355206;8351.95824020879;8537.060923298463;8540.658373665046;8551.102134275874;8563.400561960665;7487.513311634753;8558.144185581423;8716.912830871705;8753.912460875374;8759.430637008605;6040.667763273018;8639.09289524597;8710.520921349324;8716.302695784354;8718.607662655195;6127.203463549755;6193.854136984673;6193.938060619381;6200.968995155041;6204.81385558434;29361.706382936325;35345.82327088374;35777.64222357769;35885.82057089724;35909;3015.6079709637825;3024.500957342036;3050.6796786337336;3088.6911308869157;3090.9072727817975;27185.592216116773;27298.5905211422;27472.313192170157;27710.44579108427;28575.428491430055;2786.6656001279775;2790.734880186379;2799.468101060792;2829.674587422452;2837.872295746696;321620;324973;325142;325316;328037.3598131994;37162.44256336157;38840.61159388426;38892.80553597271;44360.77819610946;49793.25310120351;48177;48289;48327.27509087366;48357.5164248353;48388.758056209495;14159.504417345344;14288.285585720672;14298.642533936527;14308.356123974447;14352.641183970276;11702.765944681229;11719.765604687858;11726.355050472306;11730.530778768923;11735.647930561927;12217.51129954792;12226.572069977508;12228.816567751492;12314.199577027464;12348.135630505778;4982.352294201731;5539.750711217925;5677.602567820296;5719.513841323451;5736.483716465538;787.3701039168642;949.3449519831295;956.8469044952774;967.67099186277;1026.4867566216892;22809.88595057014;23484.53030939372;23779.286621401385;23799.52400952006;24011.63982540263;1043;1081.734974931147;1112.219030752207;1113.142879982409;1125.291066628019;12065.974392176588;12071.577494787816;12074.517019319304;12099.637010889688;12166.209196402382;433477;434703;434970.8251458786;435353;435987;54339;54398.45601544013;54459;54464.72767636136;54782.178267326024;1285.5050805439787;1427.1908159977938;1527.5264667953193;1529.2277399912973;1536.6696160325585;22825.429364266027;23206.76793232046;23381.649275260545;23431.179908703114;23582.29253122409;37086.62913370832;37112.44331334978;37136.957467339555;37145.6285437153;37161.256774864894;433076.66923330363;435352.8232358818;435479;435897;435899;23764.405889852893;28831.99088031909;30266;30270;32004.51993220057;37612;38377.040573985876;38394.42408363933;39834.004149896486;40870.1825963485;26916.654167291166;28376;28933.42133157367;29369.265768355963;29544;28428.85785571059;28842.990495332564;29353;29571;29740.107796766133;31063.651088847128;33624.49563256504;34733.47899781556;35532.644673553965;35618.28763424769;29081.272968175967;29231.85384073066;29248.853755731085;29920.401591967602;30171.849140754155;22918.854057296736;23206.1877834275;23361.182358617367;23511.41221469477;23539.764602354444 05:06:01 INFO - PID 1653 | |2;jquery.html;423.64740239778683;431.8725975837128;433.7332540487601;434.16206721028414;451.74250677114037;19460.805391946076;21171.99999999998;21995.120195192172;22042.88978555105;22089.447763805892;18962;21835.890820545876;21899.67150492744;22329.330120096383;22611.886940565317;6192.195014648089;6475.902861457082;6478.319776423478;6482.773102941398;6489.772857949973;5915.319738230094;6255.12428260044;6326.430621244087;6329.841753956165;6335.936640633581;5928.673922934258;6255.624662520263;6289.182406287199;6301.1808464899495;6304.117423560705;6055.303640081403;6165.167702360169;6179.289381721114;6184.103305020747;6188.907166392462;5354.063038968165;5499;5530.695811730394;5556.611037227396;5579.8884022319735;27231.863840680868;27561;27745.861270693516;27821.304467388276;28109.875604975776;2004.7293615362032;2012.22529326209;2019.6970454431805;2047.4062521868789;2052.7126202331688;15211.543653690296;16610.916945415196;16661.91697539668;16936.491905242863;17328.566785830328;1523.7866698662197;1673.6150685342438;1683.1920678074594;1694.2545280076727;1729.697302971975;120133.78862796673;142660.28669856585;151589.24205379013;154812;155639;12075.396230188455;12078.939605301917;12220.877791222152;12292.446839892047;12436.316002619942;16402.179891005402;16421.261043253082;16464;16467.670646587;16471.34114635425;8154.5514996674565;8452.492850428995;8464.57677116154;8619.569021548898;8641.654333826702;6604.900926486011;7835.177306382861;7852.607369631495;7882.487638303492;8053.6375863086305;6265;7722.150563438017;7733.613319334123;7735.767926962088;7755.650995705207;1821.906855886484;2123.74515058194;2128.957420851574;2130.627140250481;2374.0147838646767;787.8660627693306;828.7306625346666;901.8196360727881;927.6057675488025;955.2071780422233;20016.2994295199;20898.58202835935;20925.476863078544;20947.37157885266;20951.8952405237;849.2144766091341;940.3182692547985;967.1682353176262;970.9514524273758;971.8250714871391;10266.640667576748;10434.478276086165;10619.415932123808;10747.086497647631;10771.246012779187;689990;702971.2177343144;703228;707782;723376;107349.38975915368;130072;132055;152111.23944380207;152200;1118.994405027986;1122.3995162587976;1138.5161306444727;1144.404909447083;1153.1985270237105;16694.666106677556;17879.10604469797;17967.5508112293;18030.008349540378;18323;58157.70921145367;59499.99999999827;60426;60500;61008;82823.5858820702;83636.58181709053;85216.5739171325;85816.57091714501;90400;8294;8522.829543409222;8588.742337729878;8901.599428025884;9156.450612963243;11119.833202501806;12514.374281286082;12869.678258043623;13286;13371.598852034454;11148.498317575566;11274.605388811353;11422.428878556206;11751.177417580688;11861.28832270032;10551.208659350734;10565.101966332948;10585.682429527127;10935.781284374427;10974.341539507655;11361.37512436824;11725.534308211474;11965;12011.399430028638;12111.970482509085;8066.556339401389;8513.40406171562;8632.179942905414;8702.47785132894;8705.825883482421;11368.374739389083;11644.2431241969;11925.0459963201;11971.580994665144;11999.64001079969 05:06:01 INFO - PID 1653 | |3;mootools.html;1176.5176277726123;1365.7541642504348;1430.6995530938502;1458.015839308466;1458.5478501664484;9092.31807614429;9538.523073846305;10553.41956192409;10853.34879907206;10865.51105200266;10535.947320263407;10672.413017284065;10677.893221067787;10680.305780124287;10681.519331630076;2004.619122366753;2425.1996841042414;2429.7448767879296;2431.0761910474084;2431.963520547193;1658.6433916707906;1967.931122410716;2094.560142370104;2264.9433764155865;2402.9279121626378;2383;2425.417899704076;2425.757424257569;2426.793722533587;2429.4047958250253;2353.376355265856;2372.0867466025534;2377.95244095118;2388.534235824015;2389.319044072431;2345.976540234593;2357.8938947747392;2386;2392.342105920868;2395.6047252203366;10746.301490403099;11025.338479691245;11040.558377664884;11042.227044106916;11053.171012174038;6157.876842463171;6377.649229292387;6405.263394709621;6417.518686098515;6445.774397896098;3968.2857085724845;3981.900452488682;4029.717919745619;4063.9796801015805;4084.305668036441;1140.9372484513349;1149.1324050342023;1159.4376727287258;1167.3054532553117;1214.2775048845922;15213.163276019815;15271.236438178046;15283.694326113638;15291.694166116728;15314.846851531454;4593.770311484413;5481.479259470344;5605.80379686709;5667.376588575254;5766.654000759968;12773.936130319475;12776.552820651232;12784.61646150617;12791.360431978364;12796.936015319863;6400.423961843457;6402.807915762534;6409.198850143732;6429.485641148697;6430.131932189188;4833.178359678793;5633.295838020247;5704.315482142087;5709.800156994485;5760.251167348218;3949.229900169497;4046.2196633481176;4107.732997355222;4349.565043495689;4369.60673539383;1401.663600735816;1406.3530775843226;1416.9504067357593;1430.2205298112553;1435.4330039634285;746.7796999885047;748.8726916424221;760.9277118673717;773.4044785515122;806.7257132574953;5189.42916279209;5390.299261096111;5657.858553536194;5880.764769409261;6118.449339559461;780.7306479264645;892.1747383670079;909.1272378516566;913.7304495173939;927.1331305229631;3627.800470974069;3639.5086663300644;3686.7787932724123;3705.3886108792285;3707.3882809336696;13640.522581709592;13919.930400347934;14073.225972571403;14115.85884141166;14135.575932722035;13418.396172172275;14046.297685115907;14054.508092216724;14069;14080.71838563223;10062.69811905644;10282.383057016603;10284.742881427874;10288.845667314847;10293.948530257301;5731.19763233156;6040.388751692878;6206.751729930752;6315.5263355247625;6350.491960643045;10345.172386209235;11768.293902365886;12449.315287659265;12510.249385036926;12533.561325353568;12462;12583.370831458573;12587.363642726754;12718.872811272138;12780.808287875876;8805.911940880509;8879.778005549655;8938.4190027648;9055.230305424113;9067.36528443029;8559.358048146538;9837.901620983985;10090.293679442368;10092.444915529422;10095.949520252352;7640;8387.287080598218;8397.538135402367;8460.788480287796;8604.48373097616;8267.669293228444;8278.544680042656;8293.38614177478;8373.33013358942;8519.531425771394;7558.735444259424;7740.26467485588;7740.342070923809;7741.612919353897;7750.186230445947;5470.863228419322;5669.149627555899;5686.800961966312;5734.655920644775;5842.152887831326;5751.1085781703905;5775.653460792366;5833.212516310244;5873.3832947539895;5950.821475355746 05:06:01 INFO - PID 1653 | |4;prototype.html;381.31744177921524;391.3835708758705;403.77792214282135;405.2401746724891;405.36762650265587;4935.3090567320605;5863.8827223455555;5892.322382925954;5992.370801065891;6035.4266344697235;4710.90578188436;5224.824414506734;5750.763585829046;5784.450477204669;5819.563532735041;4114.19773144237;4360.302351623749;4676.6492513061485;4684.180268453007;4700.647451441156;3897.5322961244547;4166.1895397177;4655.348251244828;4697.248440249561;4734.431868175807;4442.600165985061;4543.159515489645;4558.652294068557;4559.67769346889;4581.266997280436;4451.310046942729;4526.660500462462;4581.3128030795315;4639.8144074237325;4643.349931009661;4123.402106694512;4140.875773726793;4147.232761939051;4150.481189851269;4159.91680166395;5458.099413596752;5612.410696876851;5759;5792.652440853562;5820.5634577406445;5399.163129714901;5413.780350056458;5418.29562156921;5431.782728690848;5446.673199608036;5277.762500687479;6185.628862268233;6369.598688288569;6403.8399040023905;6417.454516366068;4585.977070114662;4609.423822022247;4627.190241707688;4632.374629425052;4663.580277775017;5755.942440575583;6610.01699490151;6658.334166583351;6682.866342673119;6695.861703510415;4127.926739047869;4338.305871060616;4684.203685373494;4697.201475749131;4733.83431579893;4038;4759.357486739246;4778.808847646124;4790.820176819539;4815.662903596784;5406.432324605938;5413.512783849473;5433.26650902131;5457.526467853657;5489.204065410493;5124.692518448905;6184.257889053252;6356.982882738832;6404.775832845828;6432.903506447407;1469.7942288079678;1508.7435136026902;1569.7991036856813;1623.602217456707;1624.9918750406173;990.7572644702094;1078.099786678117;1139.6922830835795;1142.4459137318395;1151.3494875395543;5545.140503222007;5772.7690892363835;5932.7330270137945;5968.686888884438;6001.219841420588;5683.943160568424;5823.242978412779;6305;6492.117285987105;6643;5295.523402893758;5476.644018138808;5782.392848750905;5934.228550288435;5941.157956265716;3061.862216200276;3241.270714089358;3454.6199918008997;3491.8952431427097;3497.370473314828;6690.364415380531;6735.158105236846;6762.222344430355;6767.898481522781;6771.559848609824;5463.72681365938;6664.435196610884;6755.3582409671;6766.830829229309;6779.661016949133;5545.72271386429;6743.1908171019795;6753.412947957226;6784.8303792404595;6794.286599906938;6566.9492881138785;6609.603423794588;6633.469322454095;6658.733650654113;6664.533802563428;6248.875022499616;6310.842228944313;6397.744090236339;6418.743250269937;6530.575512591667;5417.891642167214;5846.924341858749;6137.281561162881;6486.610803351814;6729.360710732472;3908.5309762828642;4220.936685949652;4416.889577760582;4658.277966915133;4717.127331443694;5467.07059799827;5615.438456154352;6576.145101136822;6598.736050557924;6645.767398141042;6301.558890877778;6310.400511951358;6340.461060809883;6366.458850997532;6373.521985850987;5347.812826551052;6011.248593925759;6222.81331560054;6308.842278943063;6311.842203944754;6135.570510064253;6164.722587483664;6171.753129874754;6198.535109866868;6269;5573.303337082864;6038.69806509664;6359.364063593789;6396.616203027647;6410.743570257137;5130.871208334161;5287.841364759063;5778.306603207642;6042.274927008787;6217.595856269328 05:06:01 INFO - PID 1653 | |5;yui.html;727.8689835829551;734.5262305812751;742.6175519607407;745.2882497215159;760.7451503746245;15090.547283581496;15883.444079457222;15956.760648590265;17432.04123773192;18460.630787384278;16228.675426491463;16808.495745127664;17075.48773536796;17144.142792860337;17327.306907723676;945.8155659646354;968.9563969621348;969.2682025071061;970.4759429907841;970.8203982263268;946.8863736351648;966.8549717542354;968.8740463739704;970.9804705059695;977.7066879936026;1012.9544170512345;1014.7209517382705;1020.5305559442666;1021.7701017271129;1023.1098943918764;1013.716159475348;1014.0265345268551;1014.4065721552901;1017.1608423051013;1017.811704834608;755.252300222781;757.1595528962847;757.6476938223752;759.810047488128;763.091920614467;15947.202639868075;16215.189240537926;16395.508134755975;16662.916685416494;16968.3212671493;14560;14674.633134171625;14754.631134221623;14788.11271323724;14817.259137043106;11517.769644607144;11551.595694150665;11913.463894124785;12117.39413029345;12140.3322817245;2919.824810511355;3041.5437684347303;3043.269615292336;3047.405755877605;3147.4491963906225;47172.52827471716;69767.65116174438;90682;104650;106539.93460065378;10820.56717731282;11224.887751122547;11246.100311975022;11753.4710938008;12144.635660930186;23280.53438931246;24087.75912240855;24119.51760964806;24162;24226;6927.376536111774;7547.8113047173165;7631.961840190764;7752;7804.3756499479905;3915.138669492707;4101.302778527657;4121.488048882758;4168.895777605523;4243.405923170759;3524.8766293179615;4246.893827654333;4253.76604286761;4259.829606815692;4267.594578515036;839.4207996482407;854.7393045121298;884.9159329863653;885.6501681835639;888.0453512474116;537.9596530260246;554.1466142141057;573.8077743955821;577.3187638586509;580.4746704232676;6654.9461433700635;8894.644214231359;8913.821723565492;9002.324825638103;9299.907000929905;558.4610850529259;578.1470387408347;579.3003909783425;581.4185814185814;583.2388732703778;3968.087549551148;4119.814608342632;4192.140611174702;4210.831566737296;4211.1998720243055;89188;100840.49579752055;102259.48870255602;102681.48659256657;106128;56041.159382609294;67024;79712;87098;87258.56370718106;74811.62594187103;74985;76105.6194719034;76538;77305.61347193229;9530.428174309563;9570.760730981781;9617;9630.374025688308;9639.614415423304;38104.83669783344;38828.670279783306;39054.21891562096;39123.804380979054;39473.618423355045;41592.584074160084;51530.742346288025;51570.74214628903;51675.966480670926;51854.22218666798;13133.36925502414;13166.275854828076;13336.599902002956;13351.198928064347;13701.843045472437;12742.299173545543;13543.932280338535;13795.912285494485;13921.217547001057;14394.640133996734;13473;13474.922006239281;13571.688437252576;13800.723985520033;13882.583522494342;13294.867051329364;13542.187468751907;13915;13992.790108148183;14151;13108.606741797761;13337.53318633843;13344.933275333562;13542.932285338511;13821;8528.914710852812;8712.607932643174;8897.199599234375;8994.280457563511;9039.68361107358;9097.859709264245;9297.953510232406;9412.576434060347;9417.48203848795;9607.423554586747 05:06:01 INFO - PID 1653 | __end_tp_report 05:06:01 INFO - PID 1653 | __start_cc_report 05:06:01 INFO - PID 1653 | _x_x_mozilla_cycle_collect,1832 05:06:01 INFO - PID 1653 | __end_cc_report 05:06:01 INFO - PID 1653 | __startTimestamp1490357161215__endTimestamp 05:06:01 INFO - PID 1653 | 05:06:01 INFO - PID 1653 | ------- Summary: start ------- 05:06:01 INFO - PID 1653 | Number of tests: 6 05:06:01 INFO - PID 1653 | 05:06:01 INFO - PID 1653 | [#0] dojo.html Cycles:165 Average:5983.72 Median:6215.75 stddev:665.28 (10.7%) stddev-sans-first:636.23 05:06:01 INFO - PID 1653 | Values: 3421.3 3441.8 3444.4 3474.6 3490.5 6079.2 6103.4 6118.8 6130.6 6154.2 6078.6 6089.5 6104.0 6106.8 6124.8 5019.5 5194.2 5446.2 5471.5 5606.1 5305.2 5527.0 5565.8 5565.9 5607.1 5414.6 5429.4 5430.9 5435.1 5444.5 5347.6 5360.7 5373.1 5374.4 5377.7 4714.8 5127.1 5293.0 5350.1 5361.0 6003.5 6019.1 6029.6 6029.8 6034.2 6318.1 6319.1 6319.5 6323.8 6327.6 6298.8 6317.4 6366.0 6376.9 6457.1 6205.7 6211.1 6241.5 6243.1 6264.8 6676.2 6681.5 6682.2 6696.4 6697.2 5106.9 6116.2 6243.2 6291.2 6291.3 6435.3 6473.1 6478.1 6483.3 6489.5 6378.4 6388.5 6395.8 6398.0 6404.1 6140.0 6208.3 6263.4 6379.7 6411.8 5201.5 5231.0 5248.1 5295.1 5306.7 4607.7 4619.2 4621.5 4628.2 4669.7 5874.9 6089.7 6131.6 6137.3 6163.6 6285.3 6298.8 6451.9 6510.0 6530.2 6150.5 6219.3 6222.3 6229.6 6231.0 5792.8 5798.9 5807.8 5818.1 5863.9 6321.7 6396.2 6402.8 6597.8 6625.4 6519.9 6550.6 6556.5 6564.9 6565.0 6572.9 6662.2 6666.1 6674.3 6689.3 6209.5 6427.0 6447.1 6449.1 6449.3 6169.6 6450.2 6475.2 6497.4 6502.9 6168.2 6244.7 6320.3 6322.8 6329.7 6148.9 6201.2 6260.2 6278.1 6316.6 6277.0 6283.3 6288.7 6289.5 6297.8 6203.5 6314.3 6327.1 6339.7 6339.7 6147.1 6159.4 6159.4 6181.4 6215.8 05:06:01 INFO - PID 1653 | 05:06:01 INFO - PID 1653 | [#1] ext.html Cycles:180 Average:52227.55 Median:180830.93 stddev:106754.17 (59.0%) stddev-sans-first:106983.58 05:06:01 INFO - PID 1653 | Values: 711.4 818.1 1147.7 1174.0 1175.2 35467.5 36271.3 36271.3 36427.0 36549.5 40055.6 40189.8 40215.6 40233.2 40266.4 6080.1 6238.9 8560.8 8699.0 8707.0 8352.0 8537.1 8540.7 8551.1 8563.4 7487.5 8558.1 8716.9 8753.9 8759.4 6040.7 8639.1 8710.5 8716.3 8718.6 6127.2 6193.9 6193.9 6201.0 6204.8 29361.7 35345.8 35777.6 35885.8 35909.0 3015.6 3024.5 3050.7 3088.7 3090.9 27185.6 27298.6 27472.3 27710.4 28575.4 2786.7 2790.7 2799.5 2829.7 2837.9 321620.0 324973.0 325142.0 325316.0 328037.4 37162.4 38840.6 38892.8 44360.8 49793.3 48177.0 48289.0 48327.3 48357.5 48388.8 14159.5 14288.3 14298.6 14308.4 14352.6 11702.8 11719.8 11726.4 11730.5 11735.6 12217.5 12226.6 12228.8 12314.2 12348.1 4982.4 5539.8 5677.6 5719.5 5736.5 787.4 949.3 956.8 967.7 1026.5 22809.9 23484.5 23779.3 23799.5 24011.6 1043.0 1081.7 1112.2 1113.1 1125.3 12066.0 12071.6 12074.5 12099.6 12166.2 433477.0 434703.0 434970.8 435353.0 435987.0 54339.0 54398.5 54459.0 54464.7 54782.2 1285.5 1427.2 1527.5 1529.2 1536.7 22825.4 23206.8 23381.6 23431.2 23582.3 37086.6 37112.4 37137.0 37145.6 37161.3 433076.7 435352.8 435479.0 435897.0 435899.0 23764.4 28832.0 30266.0 30270.0 32004.5 37612.0 38377.0 38394.4 39834.0 40870.2 26916.7 28376.0 28933.4 29369.3 29544.0 28428.9 28843.0 29353.0 29571.0 29740.1 31063.7 33624.5 34733.5 35532.6 35618.3 29081.3 29231.9 29248.9 29920.4 30171.8 22918.9 23206.2 23361.2 23511.4 23539.8 05:06:01 INFO - PID 1653 | 05:06:01 INFO - PID 1653 | [#2] jquery.html Cycles:180 Average:39848.20 Median:22066.17 stddev:117664.99 (533.2%) stddev-sans-first:117957.83 05:06:01 INFO - PID 1653 | Values: 423.6 431.9 433.7 434.2 451.7 19460.8 21172.0 21995.1 22042.9 22089.4 18962.0 21835.9 21899.7 22329.3 22611.9 6192.2 6475.9 6478.3 6482.8 6489.8 5915.3 6255.1 6326.4 6329.8 6335.9 5928.7 6255.6 6289.2 6301.2 6304.1 6055.3 6165.2 6179.3 6184.1 6188.9 5354.1 5499.0 5530.7 5556.6 5579.9 27231.9 27561.0 27745.9 27821.3 28109.9 2004.7 2012.2 2019.7 2047.4 2052.7 15211.5 16610.9 16661.9 16936.5 17328.6 1523.8 1673.6 1683.2 1694.3 1729.7 120133.8 142660.3 151589.2 154812.0 155639.0 12075.4 12078.9 12220.9 12292.4 12436.3 16402.2 16421.3 16464.0 16467.7 16471.3 8154.6 8452.5 8464.6 8619.6 8641.7 6604.9 7835.2 7852.6 7882.5 8053.6 6265.0 7722.2 7733.6 7735.8 7755.7 1821.9 2123.7 2129.0 2130.6 2374.0 787.9 828.7 901.8 927.6 955.2 20016.3 20898.6 20925.5 20947.4 20951.9 849.2 940.3 967.2 971.0 971.8 10266.6 10434.5 10619.4 10747.1 10771.2 689990.0 702971.2 703228.0 707782.0 723376.0 107349.4 130072.0 132055.0 152111.2 152200.0 1119.0 1122.4 1138.5 1144.4 1153.2 16694.7 17879.1 17967.6 18030.0 18323.0 58157.7 59500.0 60426.0 60500.0 61008.0 82823.6 83636.6 85216.6 85816.6 90400.0 8294.0 8522.8 8588.7 8901.6 9156.5 11119.8 12514.4 12869.7 13286.0 13371.6 11148.5 11274.6 11422.4 11751.2 11861.3 10551.2 10565.1 10585.7 10935.8 10974.3 11361.4 11725.5 11965.0 12011.4 12112.0 8066.6 8513.4 8632.2 8702.5 8705.8 11368.4 11644.2 11925.0 11971.6 11999.6 05:06:01 INFO - PID 1653 | 05:06:01 INFO - PID 1653 | [#3] mootools.html Cycles:180 Average:6713.83 Median:3029.88 stddev:4231.26 (139.7%) stddev-sans-first:4222.67 05:06:01 INFO - PID 1653 | Values: 1176.5 1365.8 1430.7 1458.0 1458.5 9092.3 9538.5 10553.4 10853.3 10865.5 10535.9 10672.4 10677.9 10680.3 10681.5 2004.6 2425.2 2429.7 2431.1 2432.0 1658.6 1967.9 2094.6 2264.9 2402.9 2383.0 2425.4 2425.8 2426.8 2429.4 2353.4 2372.1 2378.0 2388.5 2389.3 2346.0 2357.9 2386.0 2392.3 2395.6 10746.3 11025.3 11040.6 11042.2 11053.2 6157.9 6377.6 6405.3 6417.5 6445.8 3968.3 3981.9 4029.7 4064.0 4084.3 1140.9 1149.1 1159.4 1167.3 1214.3 15213.2 15271.2 15283.7 15291.7 15314.8 4593.8 5481.5 5605.8 5667.4 5766.7 12773.9 12776.6 12784.6 12791.4 12796.9 6400.4 6402.8 6409.2 6429.5 6430.1 4833.2 5633.3 5704.3 5709.8 5760.3 3949.2 4046.2 4107.7 4349.6 4369.6 1401.7 1406.4 1417.0 1430.2 1435.4 746.8 748.9 760.9 773.4 806.7 5189.4 5390.3 5657.9 5880.8 6118.4 780.7 892.2 909.1 913.7 927.1 3627.8 3639.5 3686.8 3705.4 3707.4 13640.5 13919.9 14073.2 14115.9 14135.6 13418.4 14046.3 14054.5 14069.0 14080.7 10062.7 10282.4 10284.7 10288.8 10293.9 5731.2 6040.4 6206.8 6315.5 6350.5 10345.2 11768.3 12449.3 12510.2 12533.6 12462.0 12583.4 12587.4 12718.9 12780.8 8805.9 8879.8 8938.4 9055.2 9067.4 8559.4 9837.9 10090.3 10092.4 10095.9 7640.0 8387.3 8397.5 8460.8 8604.5 8267.7 8278.5 8293.4 8373.3 8519.5 7558.7 7740.3 7740.3 7741.6 7750.2 5470.9 5669.1 5686.8 5734.7 5842.2 5751.1 5775.7 5833.2 5873.4 5950.8 05:06:01 INFO - PID 1653 | 05:06:01 INFO - PID 1653 | [#4] prototype.html Cycles:180 Average:5178.36 Median:5592.86 stddev:1542.84 (27.6%) stddev-sans-first:1504.56 05:06:01 INFO - PID 1653 | Values: 381.3 391.4 403.8 405.2 405.4 4935.3 5863.9 5892.3 5992.4 6035.4 4710.9 5224.8 5750.8 5784.5 5819.6 4114.2 4360.3 4676.6 4684.2 4700.6 3897.5 4166.2 4655.3 4697.2 4734.4 4442.6 4543.2 4558.7 4559.7 4581.3 4451.3 4526.7 4581.3 4639.8 4643.3 4123.4 4140.9 4147.2 4150.5 4159.9 5458.1 5612.4 5759.0 5792.7 5820.6 5399.2 5413.8 5418.3 5431.8 5446.7 5277.8 6185.6 6369.6 6403.8 6417.5 4586.0 4609.4 4627.2 4632.4 4663.6 5755.9 6610.0 6658.3 6682.9 6695.9 4127.9 4338.3 4684.2 4697.2 4733.8 4038.0 4759.4 4778.8 4790.8 4815.7 5406.4 5413.5 5433.3 5457.5 5489.2 5124.7 6184.3 6357.0 6404.8 6432.9 1469.8 1508.7 1569.8 1623.6 1625.0 990.8 1078.1 1139.7 1142.4 1151.3 5545.1 5772.8 5932.7 5968.7 6001.2 5683.9 5823.2 6305.0 6492.1 6643.0 5295.5 5476.6 5782.4 5934.2 5941.2 3061.9 3241.3 3454.6 3491.9 3497.4 6690.4 6735.2 6762.2 6767.9 6771.6 5463.7 6664.4 6755.4 6766.8 6779.7 5545.7 6743.2 6753.4 6784.8 6794.3 6566.9 6609.6 6633.5 6658.7 6664.5 6248.9 6310.8 6397.7 6418.7 6530.6 5417.9 5846.9 6137.3 6486.6 6729.4 3908.5 4220.9 4416.9 4658.3 4717.1 5467.1 5615.4 6576.1 6598.7 6645.8 6301.6 6310.4 6340.5 6366.5 6373.5 5347.8 6011.2 6222.8 6308.8 6311.8 6135.6 6164.7 6171.8 6198.5 6269.0 5573.3 6038.7 6359.4 6396.6 6410.7 5130.9 5287.8 5778.3 6042.3 6217.6 05:06:01 INFO - PID 1653 | 05:06:01 INFO - PID 1653 | [#5] yui.html Cycles:180 Average:18623.63 Median:4120.65 stddev:25886.55 (628.2%) stddev-sans-first:25924.30 05:06:01 INFO - PID 1653 | Values: 727.9 734.5 742.6 745.3 760.7 15090.5 15883.4 15956.8 17432.0 18460.6 16228.7 16808.5 17075.5 17144.1 17327.3 945.8 969.0 969.3 970.5 970.8 946.9 966.9 968.9 971.0 977.7 1013.0 1014.7 1020.5 1021.8 1023.1 1013.7 1014.0 1014.4 1017.2 1017.8 755.3 757.2 757.6 759.8 763.1 15947.2 16215.2 16395.5 16662.9 16968.3 14560.0 14674.6 14754.6 14788.1 14817.3 11517.8 11551.6 11913.5 12117.4 12140.3 2919.8 3041.5 3043.3 3047.4 3147.4 47172.5 69767.7 90682.0 104650.0 106539.9 10820.6 11224.9 11246.1 11753.5 12144.6 23280.5 24087.8 24119.5 24162.0 24226.0 6927.4 7547.8 7632.0 7752.0 7804.4 3915.1 4101.3 4121.5 4168.9 4243.4 3524.9 4246.9 4253.8 4259.8 4267.6 839.4 854.7 884.9 885.7 888.0 538.0 554.1 573.8 577.3 580.5 6654.9 8894.6 8913.8 9002.3 9299.9 558.5 578.1 579.3 581.4 583.2 3968.1 4119.8 4192.1 4210.8 4211.2 89188.0 100840.5 102259.5 102681.5 106128.0 56041.2 67024.0 79712.0 87098.0 87258.6 74811.6 74985.0 76105.6 76538.0 77305.6 9530.4 9570.8 9617.0 9630.4 9639.6 38104.8 38828.7 39054.2 39123.8 39473.6 41592.6 51530.7 51570.7 51676.0 51854.2 13133.4 13166.3 13336.6 13351.2 13701.8 12742.3 13543.9 13795.9 13921.2 14394.6 13473.0 13474.9 13571.7 13800.7 13882.6 13294.9 13542.2 13915.0 13992.8 14151.0 13108.6 13337.5 13344.9 13542.9 13821.0 8528.9 8712.6 8897.2 8994.3 9039.7 9097.9 9298.0 9412.6 9417.5 9607.4 05:06:01 INFO - PID 1653 | -------- Summary: end -------- 05:06:01 INFO - PID 1653 | 05:06:01 INFO - TEST-INFO | 1653: exit 0 05:06:01 INFO - TEST-OK | dromaeo_css | took 1122395ms 05:06:01 INFO - TEST-START | kraken 05:06:01 INFO - operating with platform_type : mac_ 05:06:01 INFO - Initialising browser for kraken test... 05:06:01 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/tmpJUTPVm/profile http://localhost:49243/getInfo.html) 05:06:04 INFO - PID 1660 | __metrics Screen width/height:1600/1200 05:06:04 INFO - PID 1660 | colorDepth:24 05:06:04 INFO - PID 1660 | Browser inner width/height: 1024/689 05:06:04 INFO - PID 1660 | __metrics 05:06:04 INFO - PID 1660 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:06:04 INFO - PID 1660 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:06:05 INFO - TEST-INFO | 1660: exit 0 05:06:05 INFO - Browser initialized. 05:06:05 INFO - Running cycle 1/1 for kraken test... 05:06:05 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/tmpJUTPVm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:06:17 INFO - PID 1662 | RSS: Main: 233906176 05:06:17 INFO - PID 1662 | 05:06:20 INFO - PID 1662 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection) 05:06:21 INFO - PID 1662 | RSS: Main: 285442048 05:06:21 INFO - PID 1662 | 05:06:23 INFO - PID 1662 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-dft) 05:06:24 INFO - PID 1662 | RSS: Main: 288010240 05:06:24 INFO - PID 1662 | 05:06:27 INFO - PID 1662 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-fft) 05:06:28 INFO - PID 1662 | RSS: Main: 380203008 05:06:28 INFO - PID 1662 | 05:06:30 INFO - PID 1662 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator) 05:06:31 INFO - PID 1662 | RSS: Main: 282603520 05:06:31 INFO - PID 1662 | 05:06:33 INFO - PID 1662 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:06:33 INFO - PID 1662 | RSS: Main: 285757440 05:06:33 INFO - PID 1662 | 05:06:36 INFO - PID 1662 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom) 05:06:37 INFO - PID 1662 | RSS: Main: 326950912 05:06:37 INFO - PID 1662 | 05:06:40 INFO - PID 1662 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate) 05:06:41 INFO - PID 1662 | RSS: Main: 343605248 05:06:41 INFO - PID 1662 | 05:06:43 INFO - PID 1662 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial) 05:06:44 INFO - PID 1662 | RSS: Main: 354463744 05:06:44 INFO - PID 1662 | 05:06:46 INFO - PID 1662 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:06:46 INFO - PID 1662 | RSS: Main: 301907968 05:06:46 INFO - PID 1662 | 05:06:48 INFO - PID 1662 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:06:49 INFO - PID 1662 | RSS: Main: 307146752 05:06:49 INFO - PID 1662 | 05:06:51 INFO - PID 1662 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:06:52 INFO - PID 1662 | RSS: Main: 308953088 05:06:52 INFO - PID 1662 | 05:06:55 INFO - PID 1662 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:06:55 INFO - PID 1662 | RSS: Main: 325455872 05:06:55 INFO - PID 1662 | 05:06:59 INFO - PID 1662 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:06:59 INFO - PID 1662 | RSS: Main: 318533632 05:06:59 INFO - PID 1662 | 05:07:01 INFO - PID 1662 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49243/tests/kraken/driver.html?testName=ai-astar) 05:07:01 INFO - PID 1662 | RSS: Main: 380047360 05:07:01 INFO - PID 1662 | 05:07:01 INFO - PID 1662 | __start_tp_report 05:07:01 INFO - PID 1662 | _x_x_mozilla_page_load 05:07:01 INFO - PID 1662 | _x_x_mozilla_page_load_details 05:07:01 INFO - PID 1662 | |i|pagename|runs| 05:07:01 INFO - PID 1662 | |0;ai-astar;112;113;113;112;113;112;112;113;113;113 05:07:01 INFO - PID 1662 | |1;audio-beat-detection;147;111;111;153;115;112;111;110;135;107 05:07:01 INFO - PID 1662 | |2;audio-dft;185;185;187;187;185;183;183;183;184;205 05:07:01 INFO - PID 1662 | |3;audio-fft;77;60;60;89;65;59;59;60;78;60 05:07:01 INFO - PID 1662 | |4;audio-oscillator;85;71;88;69;70;68;83;69;68;86 05:07:01 INFO - PID 1662 | |5;imaging-gaussian-blur;123;134;86;87;87;86;86;87;87;87 05:07:01 INFO - PID 1662 | |6;imaging-darkroom;94;94;93;94;95;96;94;93;94;98 05:07:01 INFO - PID 1662 | |7;imaging-desaturate;84;84;84;85;83;93;86;83;84;84 05:07:01 INFO - PID 1662 | |8;json-parse-financial;62;60;61;61;61;62;60;61;61;60 05:07:01 INFO - PID 1662 | |9;json-stringify-tinderbox;54;59;58;68;63;62;58;58;58;59 05:07:01 INFO - PID 1662 | |10;stanford-crypto-aes;98;103;83;86;83;83;82;83;82;83 05:07:01 INFO - PID 1662 | |11;stanford-crypto-ccm;139;144;147;146;132;139;143;148;180;140 05:07:01 INFO - PID 1662 | |12;stanford-crypto-pbkdf2;183;186;187;186;189;187;192;181;188;185 05:07:01 INFO - PID 1662 | |13;stanford-crypto-sha256-iterative;68;67;68;68;68;68;69;67;68;67 05:07:01 INFO - PID 1662 | __end_tp_report 05:07:01 INFO - PID 1662 | __start_cc_report 05:07:01 INFO - PID 1662 | _x_x_mozilla_cycle_collect,2165 05:07:01 INFO - PID 1662 | __end_cc_report 05:07:01 INFO - PID 1662 | __startTimestamp1490357221719__endTimestamp 05:07:01 INFO - PID 1662 | 05:07:01 INFO - PID 1662 | ------- Summary: start ------- 05:07:01 INFO - PID 1662 | Number of tests: 14 05:07:01 INFO - PID 1662 | 05:07:01 INFO - PID 1662 | [#0] ai-astar Cycles:10 Average:112.60 Median:113.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 05:07:01 INFO - PID 1662 | Values: 112.0 113.0 113.0 112.0 113.0 112.0 112.0 113.0 113.0 113.0 05:07:01 INFO - PID 1662 | 05:07:01 INFO - PID 1662 | [#1] audio-beat-detection Cycles:10 Average:121.20 Median:113.50 stddev:17.09 (15.1%) stddev-sans-first:15.37 05:07:01 INFO - PID 1662 | Values: 147.0 111.0 111.0 153.0 115.0 112.0 111.0 110.0 135.0 107.0 05:07:01 INFO - PID 1662 | 05:07:01 INFO - PID 1662 | [#2] audio-dft Cycles:10 Average:186.70 Median:185.00 stddev:6.60 (3.6%) stddev-sans-first:6.97 05:07:01 INFO - PID 1662 | Values: 185.0 185.0 187.0 187.0 185.0 183.0 183.0 183.0 184.0 205.0 05:07:01 INFO - PID 1662 | 05:07:01 INFO - PID 1662 | [#3] audio-fft Cycles:10 Average:66.70 Median:62.50 stddev:10.71 (17.1%) stddev-sans-first:10.69 05:07:01 INFO - PID 1662 | Values: 77.0 60.0 60.0 89.0 65.0 59.0 59.0 60.0 78.0 60.0 05:07:01 INFO - PID 1662 | 05:07:01 INFO - PID 1662 | [#4] audio-oscillator Cycles:10 Average:75.70 Median:77.00 stddev:8.56 (11.1%) stddev-sans-first:8.40 05:07:01 INFO - PID 1662 | Values: 85.0 71.0 88.0 69.0 70.0 68.0 83.0 69.0 68.0 86.0 05:07:01 INFO - PID 1662 | 05:07:01 INFO - PID 1662 | [#5] imaging-gaussian-blur Cycles:10 Average:95.00 Median:87.00 stddev:17.85 (20.5%) stddev-sans-first:15.80 05:07:01 INFO - PID 1662 | Values: 123.0 134.0 86.0 87.0 87.0 86.0 86.0 87.0 87.0 87.0 05:07:01 INFO - PID 1662 | 05:07:01 INFO - PID 1662 | [#6] imaging-darkroom Cycles:10 Average:94.50 Median:94.00 stddev:1.51 (1.6%) stddev-sans-first:1.59 05:07:01 INFO - PID 1662 | Values: 94.0 94.0 93.0 94.0 95.0 96.0 94.0 93.0 94.0 98.0 05:07:01 INFO - PID 1662 | 05:07:01 INFO - PID 1662 | [#7] imaging-desaturate Cycles:10 Average:85.00 Median:84.00 stddev:2.94 (3.5%) stddev-sans-first:3.10 05:07:01 INFO - PID 1662 | Values: 84.0 84.0 84.0 85.0 83.0 93.0 86.0 83.0 84.0 84.0 05:07:01 INFO - PID 1662 | 05:07:01 INFO - PID 1662 | [#8] json-parse-financial Cycles:10 Average:60.90 Median:61.00 stddev:0.74 (1.2%) stddev-sans-first:0.67 05:07:01 INFO - PID 1662 | Values: 62.0 60.0 61.0 61.0 61.0 62.0 60.0 61.0 61.0 60.0 05:07:01 INFO - PID 1662 | 05:07:01 INFO - PID 1662 | [#9] json-stringify-tinderbox Cycles:10 Average:59.70 Median:59.00 stddev:3.80 (6.4%) stddev-sans-first:3.43 05:07:01 INFO - PID 1662 | Values: 54.0 59.0 58.0 68.0 63.0 62.0 58.0 58.0 58.0 59.0 05:07:01 INFO - PID 1662 | 05:07:01 INFO - PID 1662 | [#10] stanford-crypto-aes Cycles:10 Average:86.60 Median:83.00 stddev:7.50 (9.0%) stddev-sans-first:6.73 05:07:01 INFO - PID 1662 | Values: 98.0 103.0 83.0 86.0 83.0 83.0 82.0 83.0 82.0 83.0 05:07:01 INFO - PID 1662 | 05:07:01 INFO - PID 1662 | [#11] stanford-crypto-ccm Cycles:10 Average:145.80 Median:145.00 stddev:12.93 (8.9%) stddev-sans-first:13.47 05:07:01 INFO - PID 1662 | Values: 139.0 144.0 147.0 146.0 132.0 139.0 143.0 148.0 180.0 140.0 05:07:01 INFO - PID 1662 | 05:07:01 INFO - PID 1662 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:186.40 Median:187.00 stddev:3.06 (1.6%) stddev-sans-first:2.99 05:07:01 INFO - PID 1662 | Values: 183.0 186.0 187.0 186.0 189.0 187.0 192.0 181.0 188.0 185.0 05:07:01 INFO - PID 1662 | 05:07:01 INFO - PID 1662 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:68.00 stddev:0.63 (0.9%) stddev-sans-first:0.67 05:07:01 INFO - PID 1662 | Values: 68.0 67.0 68.0 68.0 68.0 68.0 69.0 67.0 68.0 67.0 05:07:01 INFO - PID 1662 | -------- Summary: end -------- 05:07:01 INFO - PID 1662 | 05:07:02 INFO - TEST-INFO | 1662: exit 0 05:07:02 INFO - TEST-OK | kraken | took 60791ms 05:07:02 INFO - SUITE-END | took 1183s 05:07:02 INFO - Completed test suite (00:19:43) 05:07:02 INFO - javascript benchmark 05:07:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7532.1758711123, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3421.298633780075, 3441.7934923904554, 3444.448888177889, 3474.5656792900886, 3490.5113284140225, 6079.179310793042, 6103.359147289531, 6118.832384214086, 6130.570860039799, 6154.230721159861, 6078.574499785017, 6089.5432842536875, 6103.97413805946, 6106.816795496131, 6124.785632502863, 5019.52314530119, 5194.194899790529, 5446.2375267462585, 5471.534919531845, 5606.131049687305, 5305.230741542474, 5526.972365138168, 5565.833025009236, 5565.9443405566035, 5607.074832652607, 5414.620976531644, 5429.4027656957705, 5430.891382172374, 5435.130379139358, 5444.482774136451, 5347.572194224453, 5360.731963401853, 5373.059714549938, 5374.408815030343, 5377.650452720561, 4714.83498077569, 5127.051495473349, 5292.994331077083, 5350.063738845725, 5361.0, 6003.489703375175, 6019.097135429677, 6029.638221706711, 6029.758809647609, 6034.24571928509, 6318.052292156213, 6319.083732858756, 6319.494440444753, 6323.810285691437, 6327.620342779448, 6298.811035668938, 6317.399847014526, 6365.968170159166, 6376.936230637681, 6457.12828768115, 6205.720742566596, 6211.130441738115, 6241.500679945593, 6243.094751261087, 6264.812055638338, 6676.198856137197, 6681.498887583451, 6682.198136223684, 6696.43080338167, 6697.162854643169, 5106.872328191751, 6116.153172518172, 6243.219597550306, 6291.182146320949, 6291.276503202191, 6435.259945106279, 6473.126127972663, 6478.060681201199, 6483.3192514786215, 6489.513286503531, 6378.362163783585, 6388.4569811566535, 6395.776147834804, 6398.0, 6404.103425520431, 6139.952147135068, 6208.255009398811, 6263.3736626337, 6379.744810207632, 6411.775587854403, 5201.479852014768, 5231.032259032091, 5248.05535003703, 5295.073362161606, 5306.681599104066, 4607.7004994675235, 4619.19164146273, 4621.491635920046, 4628.190066738307, 4669.696469729457, 5874.9118763218585, 6089.665068421191, 6131.601445906002, 6137.294211165773, 6163.599366041282, 6285.308616052231, 6298.842528936813, 6451.870962580722, 6510.0, 6530.183727034121, 6150.538709596798, 6219.284782250009, 6222.284437289679, 6229.626222426669, 6231.034189700604, 5792.768289268466, 5798.892032999884, 5807.796727114531, 5818.0981947798155, 5863.853403664943, 6321.652309123042, 6396.232452105591, 6402.775902843378, 6597.80206593803, 6625.370589793962, 6519.869602608016, 6550.639714815731, 6556.541042127005, 6564.868702626016, 6565.015247712881, 6572.868542629025, 6662.233843108104, 6666.100076489612, 6674.26583075871, 6689.2976237496305, 6209.472194863307, 6426.967865160645, 6447.065175549613, 6449.097126402214, 6449.322821103904, 6169.598976066542, 6450.193725784277, 6475.158229430144, 6497.4477169441125, 6502.934970650233, 6168.167297414791, 6244.65654389013, 6320.336364681642, 6322.841928951813, 6329.7151628175925, 6148.907766383597, 6201.193844800147, 6260.248770147429, 6278.121063051268, 6316.589421687576, 6277.0, 6283.277423096402, 6288.65412402304, 6289.465395441256, 6297.779577714758, 6203.534734894991, 6314.273858506331, 6327.050942358683, 6339.683015849097, 6339.683015849281, 6147.0779383092895, 6159.384061593805, 6159.445649891352, 6181.412765787243, 6215.751369945152], "value": 5940.470238750196, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [711.4486273138318, 818.1409520003996, 1147.6786499780064, 1173.9941300293497, 1175.2008634128788, 35467.46798798017, 36271.2745745085, 36271.27457450856, 36427.0, 36549.45175822365, 40055.59944400555, 40189.79430617079, 40215.59784402155, 40233.19533609326, 40266.39600405996, 6080.148779170898, 6238.906416403757, 8560.785980350478, 8698.956505217466, 8707.042225355206, 8351.95824020879, 8537.060923298463, 8540.658373665046, 8551.102134275874, 8563.400561960665, 7487.513311634753, 8558.144185581423, 8716.912830871705, 8753.912460875374, 8759.430637008605, 6040.667763273018, 8639.09289524597, 8710.520921349324, 8716.302695784354, 8718.607662655195, 6127.203463549755, 6193.854136984673, 6193.938060619381, 6200.968995155041, 6204.81385558434, 29361.706382936325, 35345.82327088374, 35777.64222357769, 35885.82057089724, 35909.0, 3015.6079709637825, 3024.500957342036, 3050.6796786337336, 3088.6911308869157, 3090.9072727817975, 27185.592216116773, 27298.5905211422, 27472.313192170157, 27710.44579108427, 28575.428491430055, 2786.6656001279775, 2790.734880186379, 2799.468101060792, 2829.674587422452, 2837.872295746696, 321620.0, 324973.0, 325142.0, 325316.0, 328037.3598131994, 37162.44256336157, 38840.61159388426, 38892.80553597271, 44360.77819610946, 49793.25310120351, 48177.0, 48289.0, 48327.27509087366, 48357.5164248353, 48388.758056209495, 14159.504417345344, 14288.285585720672, 14298.642533936527, 14308.356123974447, 14352.641183970276, 11702.765944681229, 11719.765604687858, 11726.355050472306, 11730.530778768923, 11735.647930561927, 12217.51129954792, 12226.572069977508, 12228.816567751492, 12314.199577027464, 12348.135630505778, 4982.352294201731, 5539.750711217925, 5677.602567820296, 5719.513841323451, 5736.483716465538, 787.3701039168642, 949.3449519831295, 956.8469044952774, 967.67099186277, 1026.4867566216892, 22809.88595057014, 23484.53030939372, 23779.286621401385, 23799.52400952006, 24011.63982540263, 1043.0, 1081.734974931147, 1112.219030752207, 1113.142879982409, 1125.291066628019, 12065.974392176588, 12071.577494787816, 12074.517019319304, 12099.637010889688, 12166.209196402382, 433477.0, 434703.0, 434970.8251458786, 435353.0, 435987.0, 54339.0, 54398.45601544013, 54459.0, 54464.72767636136, 54782.178267326024, 1285.5050805439787, 1427.1908159977938, 1527.5264667953193, 1529.2277399912973, 1536.6696160325585, 22825.429364266027, 23206.76793232046, 23381.649275260545, 23431.179908703114, 23582.29253122409, 37086.62913370832, 37112.44331334978, 37136.957467339555, 37145.6285437153, 37161.256774864894, 433076.66923330363, 435352.8232358818, 435479.0, 435897.0, 435899.0, 23764.405889852893, 28831.99088031909, 30266.0, 30270.0, 32004.51993220057, 37612.0, 38377.040573985876, 38394.42408363933, 39834.004149896486, 40870.1825963485, 26916.654167291166, 28376.0, 28933.42133157367, 29369.265768355963, 29544.0, 28428.85785571059, 28842.990495332564, 29353.0, 29571.0, 29740.107796766133, 31063.651088847128, 33624.49563256504, 34733.47899781556, 35532.644673553965, 35618.28763424769, 29081.272968175967, 29231.85384073066, 29248.853755731085, 29920.401591967602, 30171.849140754155, 22918.854057296736, 23206.1877834275, 23361.182358617367, 23511.41221469477, 23539.764602354444], "value": 17030.488514959008, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [423.64740239778683, 431.8725975837128, 433.7332540487601, 434.16206721028414, 451.74250677114037, 19460.805391946076, 21171.99999999998, 21995.120195192172, 22042.88978555105, 22089.447763805892, 18962.0, 21835.890820545876, 21899.67150492744, 22329.330120096383, 22611.886940565317, 6192.195014648089, 6475.902861457082, 6478.319776423478, 6482.773102941398, 6489.772857949973, 5915.319738230094, 6255.12428260044, 6326.430621244087, 6329.841753956165, 6335.936640633581, 5928.673922934258, 6255.624662520263, 6289.182406287199, 6301.1808464899495, 6304.117423560705, 6055.303640081403, 6165.167702360169, 6179.289381721114, 6184.103305020747, 6188.907166392462, 5354.063038968165, 5499.0, 5530.695811730394, 5556.611037227396, 5579.8884022319735, 27231.863840680868, 27561.0, 27745.861270693516, 27821.304467388276, 28109.875604975776, 2004.7293615362032, 2012.22529326209, 2019.6970454431805, 2047.4062521868789, 2052.7126202331688, 15211.543653690296, 16610.916945415196, 16661.91697539668, 16936.491905242863, 17328.566785830328, 1523.7866698662197, 1673.6150685342438, 1683.1920678074594, 1694.2545280076727, 1729.697302971975, 120133.78862796673, 142660.28669856585, 151589.24205379013, 154812.0, 155639.0, 12075.396230188455, 12078.939605301917, 12220.877791222152, 12292.446839892047, 12436.316002619942, 16402.179891005402, 16421.261043253082, 16464.0, 16467.670646587, 16471.34114635425, 8154.5514996674565, 8452.492850428995, 8464.57677116154, 8619.569021548898, 8641.654333826702, 6604.900926486011, 7835.177306382861, 7852.607369631495, 7882.487638303492, 8053.6375863086305, 6265.0, 7722.150563438017, 7733.613319334123, 7735.767926962088, 7755.650995705207, 1821.906855886484, 2123.74515058194, 2128.957420851574, 2130.627140250481, 2374.0147838646767, 787.8660627693306, 828.7306625346666, 901.8196360727881, 927.6057675488025, 955.2071780422233, 20016.2994295199, 20898.58202835935, 20925.476863078544, 20947.37157885266, 20951.8952405237, 849.2144766091341, 940.3182692547985, 967.1682353176262, 970.9514524273758, 971.8250714871391, 10266.640667576748, 10434.478276086165, 10619.415932123808, 10747.086497647631, 10771.246012779187, 689990.0, 702971.2177343144, 703228.0, 707782.0, 723376.0, 107349.38975915368, 130072.0, 132055.0, 152111.23944380207, 152200.0, 1118.994405027986, 1122.3995162587976, 1138.5161306444727, 1144.404909447083, 1153.1985270237105, 16694.666106677556, 17879.10604469797, 17967.5508112293, 18030.008349540378, 18323.0, 58157.70921145367, 59499.99999999827, 60426.0, 60500.0, 61008.0, 82823.5858820702, 83636.58181709053, 85216.5739171325, 85816.57091714501, 90400.0, 8294.0, 8522.829543409222, 8588.742337729878, 8901.599428025884, 9156.450612963243, 11119.833202501806, 12514.374281286082, 12869.678258043623, 13286.0, 13371.598852034454, 11148.498317575566, 11274.605388811353, 11422.428878556206, 11751.177417580688, 11861.28832270032, 10551.208659350734, 10565.101966332948, 10585.682429527127, 10935.781284374427, 10974.341539507655, 11361.37512436824, 11725.534308211474, 11965.0, 12011.399430028638, 12111.970482509085, 8066.556339401389, 8513.40406171562, 8632.179942905414, 8702.47785132894, 8705.825883482421, 11368.374739389083, 11644.2431241969, 11925.0459963201, 11971.580994665144, 11999.64001079969], "value": 10225.44495744499, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1176.5176277726123, 1365.7541642504348, 1430.6995530938502, 1458.015839308466, 1458.5478501664484, 9092.31807614429, 9538.523073846305, 10553.41956192409, 10853.34879907206, 10865.51105200266, 10535.947320263407, 10672.413017284065, 10677.893221067787, 10680.305780124287, 10681.519331630076, 2004.619122366753, 2425.1996841042414, 2429.7448767879296, 2431.0761910474084, 2431.963520547193, 1658.6433916707906, 1967.931122410716, 2094.560142370104, 2264.9433764155865, 2402.9279121626378, 2383.0, 2425.417899704076, 2425.757424257569, 2426.793722533587, 2429.4047958250253, 2353.376355265856, 2372.0867466025534, 2377.95244095118, 2388.534235824015, 2389.319044072431, 2345.976540234593, 2357.8938947747392, 2386.0, 2392.342105920868, 2395.6047252203366, 10746.301490403099, 11025.338479691245, 11040.558377664884, 11042.227044106916, 11053.171012174038, 6157.876842463171, 6377.649229292387, 6405.263394709621, 6417.518686098515, 6445.774397896098, 3968.2857085724845, 3981.900452488682, 4029.717919745619, 4063.9796801015805, 4084.305668036441, 1140.9372484513349, 1149.1324050342023, 1159.4376727287258, 1167.3054532553117, 1214.2775048845922, 15213.163276019815, 15271.236438178046, 15283.694326113638, 15291.694166116728, 15314.846851531454, 4593.770311484413, 5481.479259470344, 5605.80379686709, 5667.376588575254, 5766.654000759968, 12773.936130319475, 12776.552820651232, 12784.61646150617, 12791.360431978364, 12796.936015319863, 6400.423961843457, 6402.807915762534, 6409.198850143732, 6429.485641148697, 6430.131932189188, 4833.178359678793, 5633.295838020247, 5704.315482142087, 5709.800156994485, 5760.251167348218, 3949.229900169497, 4046.2196633481176, 4107.732997355222, 4349.565043495689, 4369.60673539383, 1401.663600735816, 1406.3530775843226, 1416.9504067357593, 1430.2205298112553, 1435.4330039634285, 746.7796999885047, 748.8726916424221, 760.9277118673717, 773.4044785515122, 806.7257132574953, 5189.42916279209, 5390.299261096111, 5657.858553536194, 5880.764769409261, 6118.449339559461, 780.7306479264645, 892.1747383670079, 909.1272378516566, 913.7304495173939, 927.1331305229631, 3627.800470974069, 3639.5086663300644, 3686.7787932724123, 3705.3886108792285, 3707.3882809336696, 13640.522581709592, 13919.930400347934, 14073.225972571403, 14115.85884141166, 14135.575932722035, 13418.396172172275, 14046.297685115907, 14054.508092216724, 14069.0, 14080.71838563223, 10062.69811905644, 10282.383057016603, 10284.742881427874, 10288.845667314847, 10293.948530257301, 5731.19763233156, 6040.388751692878, 6206.751729930752, 6315.5263355247625, 6350.491960643045, 10345.172386209235, 11768.293902365886, 12449.315287659265, 12510.249385036926, 12533.561325353568, 12462.0, 12583.370831458573, 12587.363642726754, 12718.872811272138, 12780.808287875876, 8805.911940880509, 8879.778005549655, 8938.4190027648, 9055.230305424113, 9067.36528443029, 8559.358048146538, 9837.901620983985, 10090.293679442368, 10092.444915529422, 10095.949520252352, 7640.0, 8387.287080598218, 8397.538135402367, 8460.788480287796, 8604.48373097616, 8267.669293228444, 8278.544680042656, 8293.38614177478, 8373.33013358942, 8519.531425771394, 7558.735444259424, 7740.26467485588, 7740.342070923809, 7741.612919353897, 7750.186230445947, 5470.863228419322, 5669.149627555899, 5686.800961966312, 5734.655920644775, 5842.152887831326, 5751.1085781703905, 5775.653460792366, 5833.212516310244, 5873.3832947539895, 5950.821475355746], "value": 5096.514727149583, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [381.31744177921524, 391.3835708758705, 403.77792214282135, 405.2401746724891, 405.36762650265587, 4935.3090567320605, 5863.8827223455555, 5892.322382925954, 5992.370801065891, 6035.4266344697235, 4710.90578188436, 5224.824414506734, 5750.763585829046, 5784.450477204669, 5819.563532735041, 4114.19773144237, 4360.302351623749, 4676.6492513061485, 4684.180268453007, 4700.647451441156, 3897.5322961244547, 4166.1895397177, 4655.348251244828, 4697.248440249561, 4734.431868175807, 4442.600165985061, 4543.159515489645, 4558.652294068557, 4559.67769346889, 4581.266997280436, 4451.310046942729, 4526.660500462462, 4581.3128030795315, 4639.8144074237325, 4643.349931009661, 4123.402106694512, 4140.875773726793, 4147.232761939051, 4150.481189851269, 4159.91680166395, 5458.099413596752, 5612.410696876851, 5759.0, 5792.652440853562, 5820.5634577406445, 5399.163129714901, 5413.780350056458, 5418.29562156921, 5431.782728690848, 5446.673199608036, 5277.762500687479, 6185.628862268233, 6369.598688288569, 6403.8399040023905, 6417.454516366068, 4585.977070114662, 4609.423822022247, 4627.190241707688, 4632.374629425052, 4663.580277775017, 5755.942440575583, 6610.01699490151, 6658.334166583351, 6682.866342673119, 6695.861703510415, 4127.926739047869, 4338.305871060616, 4684.203685373494, 4697.201475749131, 4733.83431579893, 4038.0, 4759.357486739246, 4778.808847646124, 4790.820176819539, 4815.662903596784, 5406.432324605938, 5413.512783849473, 5433.26650902131, 5457.526467853657, 5489.204065410493, 5124.692518448905, 6184.257889053252, 6356.982882738832, 6404.775832845828, 6432.903506447407, 1469.7942288079678, 1508.7435136026902, 1569.7991036856813, 1623.602217456707, 1624.9918750406173, 990.7572644702094, 1078.099786678117, 1139.6922830835795, 1142.4459137318395, 1151.3494875395543, 5545.140503222007, 5772.7690892363835, 5932.7330270137945, 5968.686888884438, 6001.219841420588, 5683.943160568424, 5823.242978412779, 6305.0, 6492.117285987105, 6643.0, 5295.523402893758, 5476.644018138808, 5782.392848750905, 5934.228550288435, 5941.157956265716, 3061.862216200276, 3241.270714089358, 3454.6199918008997, 3491.8952431427097, 3497.370473314828, 6690.364415380531, 6735.158105236846, 6762.222344430355, 6767.898481522781, 6771.559848609824, 5463.72681365938, 6664.435196610884, 6755.3582409671, 6766.830829229309, 6779.661016949133, 5545.72271386429, 6743.1908171019795, 6753.412947957226, 6784.8303792404595, 6794.286599906938, 6566.9492881138785, 6609.603423794588, 6633.469322454095, 6658.733650654113, 6664.533802563428, 6248.875022499616, 6310.842228944313, 6397.744090236339, 6418.743250269937, 6530.575512591667, 5417.891642167214, 5846.924341858749, 6137.281561162881, 6486.610803351814, 6729.360710732472, 3908.5309762828642, 4220.936685949652, 4416.889577760582, 4658.277966915133, 4717.127331443694, 5467.07059799827, 5615.438456154352, 6576.145101136822, 6598.736050557924, 6645.767398141042, 6301.558890877778, 6310.400511951358, 6340.461060809883, 6366.458850997532, 6373.521985850987, 5347.812826551052, 6011.248593925759, 6222.81331560054, 6308.842278943063, 6311.842203944754, 6135.570510064253, 6164.722587483664, 6171.753129874754, 6198.535109866868, 6269.0, 5573.303337082864, 6038.69806509664, 6359.364063593789, 6396.616203027647, 6410.743570257137, 5130.871208334161, 5287.841364759063, 5778.306603207642, 6042.274927008787, 6217.595856269328], "value": 4707.247023540024, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [727.8689835829551, 734.5262305812751, 742.6175519607407, 745.2882497215159, 760.7451503746245, 15090.547283581496, 15883.444079457222, 15956.760648590265, 17432.04123773192, 18460.630787384278, 16228.675426491463, 16808.495745127664, 17075.48773536796, 17144.142792860337, 17327.306907723676, 945.8155659646354, 968.9563969621348, 969.2682025071061, 970.4759429907841, 970.8203982263268, 946.8863736351648, 966.8549717542354, 968.8740463739704, 970.9804705059695, 977.7066879936026, 1012.9544170512345, 1014.7209517382705, 1020.5305559442666, 1021.7701017271129, 1023.1098943918764, 1013.716159475348, 1014.0265345268551, 1014.4065721552901, 1017.1608423051013, 1017.811704834608, 755.252300222781, 757.1595528962847, 757.6476938223752, 759.810047488128, 763.091920614467, 15947.202639868075, 16215.189240537926, 16395.508134755975, 16662.916685416494, 16968.3212671493, 14560.0, 14674.633134171625, 14754.631134221623, 14788.11271323724, 14817.259137043106, 11517.769644607144, 11551.595694150665, 11913.463894124785, 12117.39413029345, 12140.3322817245, 2919.824810511355, 3041.5437684347303, 3043.269615292336, 3047.405755877605, 3147.4491963906225, 47172.52827471716, 69767.65116174438, 90682.0, 104650.0, 106539.93460065378, 10820.56717731282, 11224.887751122547, 11246.100311975022, 11753.4710938008, 12144.635660930186, 23280.53438931246, 24087.75912240855, 24119.51760964806, 24162.0, 24226.0, 6927.376536111774, 7547.8113047173165, 7631.961840190764, 7752.0, 7804.3756499479905, 3915.138669492707, 4101.302778527657, 4121.488048882758, 4168.895777605523, 4243.405923170759, 3524.8766293179615, 4246.893827654333, 4253.76604286761, 4259.829606815692, 4267.594578515036, 839.4207996482407, 854.7393045121298, 884.9159329863653, 885.6501681835639, 888.0453512474116, 537.9596530260246, 554.1466142141057, 573.8077743955821, 577.3187638586509, 580.4746704232676, 6654.9461433700635, 8894.644214231359, 8913.821723565492, 9002.324825638103, 9299.907000929905, 558.4610850529259, 578.1470387408347, 579.3003909783425, 581.4185814185814, 583.2388732703778, 3968.087549551148, 4119.814608342632, 4192.140611174702, 4210.831566737296, 4211.1998720243055, 89188.0, 100840.49579752055, 102259.48870255602, 102681.48659256657, 106128.0, 56041.159382609294, 67024.0, 79712.0, 87098.0, 87258.56370718106, 74811.62594187103, 74985.0, 76105.6194719034, 76538.0, 77305.61347193229, 9530.428174309563, 9570.760730981781, 9617.0, 9630.374025688308, 9639.614415423304, 38104.83669783344, 38828.670279783306, 39054.21891562096, 39123.804380979054, 39473.618423355045, 41592.584074160084, 51530.742346288025, 51570.74214628903, 51675.966480670926, 51854.22218666798, 13133.36925502414, 13166.275854828076, 13336.599902002956, 13351.198928064347, 13701.843045472437, 12742.299173545543, 13543.932280338535, 13795.912285494485, 13921.217547001057, 14394.640133996734, 13473.0, 13474.922006239281, 13571.688437252576, 13800.723985520033, 13882.583522494342, 13294.867051329364, 13542.187468751907, 13915.0, 13992.790108148183, 14151.0, 13108.606741797761, 13337.53318633843, 13344.933275333562, 13542.932285338511, 13821.0, 8528.914710852812, 8712.607932643174, 8897.199599234375, 8994.280457563511, 9039.68361107358, 9097.859709264245, 9297.953510232406, 9412.576434060347, 9417.48203848795, 9607.423554586747], "value": 7357.337325917205, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1444.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 113.0, 113.0, 112.0, 113.0, 112.0, 112.0, 113.0, 113.0, 113.0], "value": 112.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 111.0, 111.0, 153.0, 115.0, 112.0, 111.0, 110.0, 135.0, 107.0], "value": 121.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 185.0, 187.0, 187.0, 185.0, 183.0, 183.0, 183.0, 184.0, 205.0], "value": 186.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 60.0, 60.0, 89.0, 65.0, 59.0, 59.0, 60.0, 78.0, 60.0], "value": 66.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 71.0, 88.0, 69.0, 70.0, 68.0, 83.0, 69.0, 68.0, 86.0], "value": 75.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 134.0, 86.0, 87.0, 87.0, 86.0, 86.0, 87.0, 87.0, 87.0], "value": 95.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 93.0, 94.0, 95.0, 96.0, 94.0, 93.0, 94.0, 98.0], "value": 94.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 84.0, 85.0, 83.0, 93.0, 86.0, 83.0, 84.0, 84.0], "value": 85.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 60.0, 61.0, 61.0, 61.0, 62.0, 60.0, 61.0, 61.0, 60.0], "value": 60.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 59.0, 58.0, 68.0, 63.0, 62.0, 58.0, 58.0, 58.0, 59.0], "value": 59.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 103.0, 83.0, 86.0, 83.0, 83.0, 82.0, 83.0, 82.0, 83.0], "value": 86.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 144.0, 147.0, 146.0, 132.0, 139.0, 143.0, 148.0, 180.0, 140.0], "value": 145.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 186.0, 187.0, 186.0, 189.0, 187.0, 192.0, 181.0, 188.0, 185.0], "value": 186.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 68.0, 68.0, 68.0, 68.0, 69.0, 67.0, 68.0, 67.0], "value": 67.8, "unit": "score"}]}]} 05:07:02 INFO - Return code: 0 05:07:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:07:03 ERROR - # TBPL SUCCESS # 05:07:03 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:07:03 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:07:03 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:07:03 INFO - 2017-03-24 05:07:03.042 screenresolution[1666:11248] starting screenresolution argv=screenresolution get 05:07:03 INFO - 2017-03-24 05:07:03.045 screenresolution[1666:11248] Display 0: 1600x1200x32@60 05:07:03 INFO - 2017-03-24 05:07:03.051 screenresolution[1667:11251] starting screenresolution argv=screenresolution list 05:07:03 INFO - Available Modes on Display 0 05:07:03 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:07:03 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:07:03 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:07:03 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:07:03 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:07:03 INFO - Intel Iris: 05:07:03 INFO - Chipset Model: Intel Iris 05:07:03 INFO - Type: GPU 05:07:03 INFO - Bus: Built-In 05:07:03 INFO - VRAM (Dynamic, Max): 1536 MB 05:07:03 INFO - Vendor: Intel (0x8086) 05:07:03 INFO - Device ID: 0x0a2e 05:07:03 INFO - Revision ID: 0x0009 05:07:03 INFO - Displays: 05:07:03 INFO - Display: 05:07:03 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:07:03 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:07:03 INFO - Display Serial Number: 1600x1200 60 05:07:03 INFO - Main Display: Yes 05:07:03 INFO - Mirror: Off 05:07:03 INFO - Online: Yes 05:07:03 INFO - Rotation: Supported 05:07:03 INFO - Return code: 0 05:07:03 INFO - Running post-action listener: _resource_record_post_action 05:07:03 INFO - [mozharness: 2017-03-24 12:07:03.300145Z] Finished run-tests step (success) 05:07:03 INFO - Running post-run listener: _resource_record_post_run 05:07:03 INFO - Total resource usage - Wall time: 1204s; CPU: 53.0%; Read bytes: 33467392; Write bytes: 515139584; Read time: 311; Write time: 1618 05:07:03 INFO - TinderboxPrint: CPU usage
53.5% 05:07:03 INFO - TinderboxPrint: I/O read bytes / time
33,467,392 / 311 05:07:03 INFO - TinderboxPrint: I/O write bytes / time
515,139,584 / 1,618 05:07:03 INFO - TinderboxPrint: CPU idle
2,242.2 (46.5%) 05:07:03 INFO - TinderboxPrint: CPU system
956.0 (19.8%) 05:07:03 INFO - TinderboxPrint: CPU user
1,619.5 (33.6%) 05:07:03 INFO - TinderboxPrint: Swap in / out
240,701,440 / 0 05:07:03 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 203393536; Write bytes: 204379648; Read time: 15701; Write time: 462 05:07:03 INFO - run-tests - Wall time: 1184s; CPU: 53.0%; Read bytes: 32533504; Write bytes: 300810752; Read time: 297; Write time: 1123 05:07:03 INFO - Running post-run listener: _upload_blobber_files 05:07:03 INFO - Blob upload gear active. 05:07:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:07:03 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:07:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:07:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:07:04 INFO - (blobuploader) - INFO - Open directory for files ... 05:07:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:07:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:07:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:07:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:07:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:07:05 INFO - (blobuploader) - INFO - Done attempting. 05:07:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:07:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:07:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:07:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:07:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:07:05 INFO - (blobuploader) - INFO - Done attempting. 05:07:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:07:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:07:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:07:07 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:07:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:07:07 INFO - (blobuploader) - INFO - Done attempting. 05:07:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:07:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:07:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:07:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:07:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:07:09 INFO - (blobuploader) - INFO - Done attempting. 05:07:09 INFO - (blobuploader) - INFO - Iteration through files over. 05:07:09 INFO - Return code: 0 05:07:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:07:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:07:09 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b2900c0b7995468b0fb6b7c7e1c6d6b8f577bb8dccfb127b221ab13c3213628c5ce1fea436434dd8661229c2414a4dc88032aad655eadf691a4cf046e010fbe7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a1870eb9531522ac35b15664b1761af969f138889b76dc00ebd31a4d7239a02a6211666c1d724c7f0e5bfd9f169bb6ee2005e87f009e2da3cb7ff939c3061f6a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/be155859cb153fff80ed65e32c79b04e996d086f5b95124fc36dfdb98300b354e75d81924312017e155a239ff0e55153f0db477a6bfaaafd0892114e319033d2", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/112ae4cee9c5f9960c78ef65a4c361bf6b550a1b5d8f1fecb8567341eb83138b02e31a40577e3f540590bfe8d6a4792c0d5a402db4335216f06a628235993af6"} 05:07:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:07:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:07:09 INFO - Contents: 05:07:09 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b2900c0b7995468b0fb6b7c7e1c6d6b8f577bb8dccfb127b221ab13c3213628c5ce1fea436434dd8661229c2414a4dc88032aad655eadf691a4cf046e010fbe7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a1870eb9531522ac35b15664b1761af969f138889b76dc00ebd31a4d7239a02a6211666c1d724c7f0e5bfd9f169bb6ee2005e87f009e2da3cb7ff939c3061f6a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/be155859cb153fff80ed65e32c79b04e996d086f5b95124fc36dfdb98300b354e75d81924312017e155a239ff0e55153f0db477a6bfaaafd0892114e319033d2", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/112ae4cee9c5f9960c78ef65a4c361bf6b550a1b5d8f1fecb8567341eb83138b02e31a40577e3f540590bfe8d6a4792c0d5a402db4335216f06a628235993af6"} 05:07:09 INFO - Running post-run listener: copy_logs_to_upload_dir 05:07:09 INFO - Copying logs to upload dir... 05:07:09 INFO - mkdir: /builds/slave/test/build/upload/logs 05:07:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1289.484069 ========= master_lag: 1.96 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 31 secs) (at 2017-03-24 05:07:11.193881) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-24 05:07:11.197183) ========= 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.B1iZRk8pAA/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.Ao87O9fdqL/Listeners TMPDIR=/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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/b2900c0b7995468b0fb6b7c7e1c6d6b8f577bb8dccfb127b221ab13c3213628c5ce1fea436434dd8661229c2414a4dc88032aad655eadf691a4cf046e010fbe7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a1870eb9531522ac35b15664b1761af969f138889b76dc00ebd31a4d7239a02a6211666c1d724c7f0e5bfd9f169bb6ee2005e87f009e2da3cb7ff939c3061f6a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/be155859cb153fff80ed65e32c79b04e996d086f5b95124fc36dfdb98300b354e75d81924312017e155a239ff0e55153f0db477a6bfaaafd0892114e319033d2", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/112ae4cee9c5f9960c78ef65a4c361bf6b550a1b5d8f1fecb8567341eb83138b02e31a40577e3f540590bfe8d6a4792c0d5a402db4335216f06a628235993af6"} build_url:https://queue.taskcluster.net/v1/task/bQuINYnKTCaU9c-GxfxzMA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011515 build_url: 'https://queue.taskcluster.net/v1/task/bQuINYnKTCaU9c-GxfxzMA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b2900c0b7995468b0fb6b7c7e1c6d6b8f577bb8dccfb127b221ab13c3213628c5ce1fea436434dd8661229c2414a4dc88032aad655eadf691a4cf046e010fbe7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a1870eb9531522ac35b15664b1761af969f138889b76dc00ebd31a4d7239a02a6211666c1d724c7f0e5bfd9f169bb6ee2005e87f009e2da3cb7ff939c3061f6a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/be155859cb153fff80ed65e32c79b04e996d086f5b95124fc36dfdb98300b354e75d81924312017e155a239ff0e55153f0db477a6bfaaafd0892114e319033d2", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/112ae4cee9c5f9960c78ef65a4c361bf6b550a1b5d8f1fecb8567341eb83138b02e31a40577e3f540590bfe8d6a4792c0d5a402db4335216f06a628235993af6"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-24 05:07:11.240744) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-24 05:07:11.241358) ========= 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.B1iZRk8pAA/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.Ao87O9fdqL/Listeners TMPDIR=/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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.005084 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-24 05:07:11.291940) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-24 05:07:11.292290) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-24 05:07:11.292731) ========= ========= Total master_lag: 2.16 =========