builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0087 starttime: 1475246120.92 results: success (0) buildid: 20160930013320 builduid: aa5c9bca12eb4c9481f5747ff57287d7 revision: 805d5fc3d66c4fa585a3de407b1e0b055f78eb58 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-30 07:35:20.917400) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-30 07:35:20.917904) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-30 07:35:20.918179) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-30 07:35:21.221409) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 07:35:21.221656) ========= 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.lS1UAURRFT/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.vKD3mPWGrw/Listeners TMPDIR=/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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 --2016-09-30 07:35:21-- 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: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 16.2M=0.001s 2016-09-30 07:35:21 (16.2 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.623878 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 07:35:21.870765) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 07:35:21.871046) ========= 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.lS1UAURRFT/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.vKD3mPWGrw/Listeners TMPDIR=/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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.028274 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 07:35:21.919147) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-30 07:35:21.919464) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 805d5fc3d66c4fa585a3de407b1e0b055f78eb58 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 805d5fc3d66c4fa585a3de407b1e0b055f78eb58 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.lS1UAURRFT/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.vKD3mPWGrw/Listeners TMPDIR=/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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 2016-09-30 07:35:21,986 truncating revision to first 12 chars 2016-09-30 07:35:21,986 Setting DEBUG logging. 2016-09-30 07:35:21,986 attempt 1/10 2016-09-30 07:35:21,986 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/805d5fc3d66c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-30 07:35:23,090 unpacking tar archive at: mozilla-aurora-805d5fc3d66c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.377924 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-30 07:35:23.319037) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-30 07:35:23.322356) ========= script_repo_revision: 805d5fc3d66c4fa585a3de407b1e0b055f78eb58 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-30 07:35:23.322730) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-30 07:35:23.323005) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-30 07:35:23.342800) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-09-30 07:35:23.343062) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.lS1UAURRFT/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.vKD3mPWGrw/Listeners TMPDIR=/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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 07:35:23 INFO - MultiFileLogger online at 20160930 07:35:23 in /builds/slave/test 07:35:23 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 07:35:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:35:23 INFO - {'append_to_log': False, 07:35:23 INFO - 'base_work_dir': '/builds/slave/test', 07:35:23 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 07:35:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:35:23 INFO - 'branch': 'Mozilla-Aurora', 07:35:23 INFO - 'buildbot_json_path': 'buildprops.json', 07:35:23 INFO - 'config_files': ('talos/mac_config.py',), 07:35:23 INFO - 'default_actions': ('clobber', 07:35:23 INFO - 'read-buildbot-config', 07:35:23 INFO - 'download-and-extract', 07:35:23 INFO - 'populate-webroot', 07:35:23 INFO - 'create-virtualenv', 07:35:23 INFO - 'install', 07:35:23 INFO - 'run-tests'), 07:35:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:35:23 INFO - 'download_minidump_stackwalk': True, 07:35:23 INFO - 'download_symbols': 'ondemand', 07:35:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:35:23 INFO - 'tooltool.py': '/tools/tooltool.py', 07:35:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:35:23 INFO - '/tools/misc-python/virtualenv.py')}, 07:35:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:35:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:35:23 INFO - 'installer_path': 'installer.exe', 07:35:23 INFO - 'log_level': 'info', 07:35:23 INFO - 'log_name': 'talos', 07:35:23 INFO - 'log_to_console': True, 07:35:23 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:35:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:35:23 INFO - 'opt_config_files': (), 07:35:23 INFO - 'pip_index': False, 07:35:23 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:35:23 INFO - 'cmd': ('bash', 07:35:23 INFO - '-c', 07:35:23 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:35:23 INFO - 'enabled': True, 07:35:23 INFO - 'halt_on_failure': False, 07:35:23 INFO - 'name': 'check_screen_resolution'},), 07:35:23 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:35:23 INFO - 'cmd': ('bash', 07:35:23 INFO - '-c', 07:35:23 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:35:23 INFO - 'enabled': True, 07:35:23 INFO - 'halt_on_failure': False, 07:35:23 INFO - 'name': 'check_screen_resolution'},), 07:35:23 INFO - 'run_cmd_checks_enabled': True, 07:35:23 INFO - 'sps_profile': False, 07:35:23 INFO - 'sps_profile_interval': 0, 07:35:23 INFO - 'suite': 'dromaeojs', 07:35:23 INFO - 'system_bits': '32', 07:35:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:35:23 INFO - 'title': 't-yosemite-r7-0087', 07:35:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:35:23 INFO - 'use_talos_json': True, 07:35:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:35:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:35:23 INFO - 'work_dir': 'build'} 07:35:23 INFO - [mozharness: 2016-09-30 14:35:23.539626Z] Running clobber step. 07:35:23 INFO - Running pre-action listener: _resource_record_pre_action 07:35:23 INFO - Running main action method: clobber 07:35:23 INFO - rmtree: /builds/slave/test/build 07:35:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:35:25 INFO - Running post-action listener: _resource_record_post_action 07:35:25 INFO - [mozharness: 2016-09-30 14:35:25.661098Z] Finished clobber step (success) 07:35:25 INFO - [mozharness: 2016-09-30 14:35:25.661246Z] Running read-buildbot-config step. 07:35:25 INFO - Running pre-action listener: _resource_record_pre_action 07:35:25 INFO - Running main action method: read_buildbot_config 07:35:25 INFO - Using buildbot properties: 07:35:25 INFO - { 07:35:25 INFO - "project": "", 07:35:25 INFO - "product": "firefox", 07:35:25 INFO - "script_repo_revision": "production", 07:35:25 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 07:35:25 INFO - "repository": "", 07:35:25 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 07:35:25 INFO - "buildid": "20160930013320", 07:35:25 INFO - "pgo_build": "False", 07:35:25 INFO - "basedir": "/builds/slave/test", 07:35:25 INFO - "buildnumber": 62, 07:35:25 INFO - "slavename": "t-yosemite-r7-0087", 07:35:25 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 07:35:25 INFO - "platform": "yosemite_r7", 07:35:25 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 07:35:25 INFO - "branch": "mozilla-aurora", 07:35:25 INFO - "repo_path": "releases/mozilla-aurora", 07:35:25 INFO - "revision": "805d5fc3d66c4fa585a3de407b1e0b055f78eb58", 07:35:25 INFO - "stage_platform": "macosx64", 07:35:25 INFO - "builduid": "aa5c9bca12eb4c9481f5747ff57287d7", 07:35:25 INFO - "slavebuilddir": "test" 07:35:25 INFO - } 07:35:25 INFO - Found installer url https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 07:35:25 INFO - Running post-action listener: _resource_record_post_action 07:35:25 INFO - [mozharness: 2016-09-30 14:35:25.664407Z] Finished read-buildbot-config step (success) 07:35:25 INFO - [mozharness: 2016-09-30 14:35:25.664532Z] Running download-and-extract step. 07:35:25 INFO - Running pre-action listener: _resource_record_pre_action 07:35:25 INFO - Running main action method: download_and_extract 07:35:25 INFO - mkdir: /builds/slave/test/build/tests 07:35:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:35:25 INFO - trying https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 07:35:25 INFO - Downloading https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 07:35:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json'}, attempt #1 07:35:26 INFO - Downloaded 1199 bytes. 07:35:26 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 07:35:26 INFO - Using the following test package requirements: 07:35:26 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 07:35:26 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 07:35:26 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 07:35:26 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 07:35:26 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 07:35:26 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 07:35:26 INFO - u'jsshell-mac.zip'], 07:35:26 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 07:35:26 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 07:35:26 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 07:35:26 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 07:35:26 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 07:35:26 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 07:35:26 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 07:35:26 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 07:35:26 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 07:35:26 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 07:35:26 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 07:35:26 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 07:35:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 07:35:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 07:35:26 INFO - Fetch https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 07:35:27 INFO - Expected file size: 16433807 07:35:34 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip', u'firefox-51.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 07:35:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 07:35:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 07:35:34 INFO - Fetch https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 07:35:35 INFO - Expected file size: 16433807 07:35:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 07:35:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 07:35:42 INFO - Fetch https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 07:35:42 INFO - Expected file size: 14414059 07:35:43 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')]} 07:35:43 INFO - trying https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 07:35:43 INFO - Downloading https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 07:35:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg'}, attempt #1 07:35:46 INFO - Downloaded 115275136 bytes. 07:35:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 07:35:46 INFO - mkdir: /builds/slave/test/properties 07:35:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:35:46 INFO - Writing to file /builds/slave/test/properties/build_url 07:35:46 INFO - Contents: 07:35:46 INFO - build_url:https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 07:35:46 INFO - Running post-action listener: _resource_record_post_action 07:35:46 INFO - Running post-action listener: set_extra_try_arguments 07:35:46 INFO - [mozharness: 2016-09-30 14:35:46.943348Z] Finished download-and-extract step (success) 07:35:46 INFO - [mozharness: 2016-09-30 14:35:46.943460Z] Running populate-webroot step. 07:35:46 INFO - Running pre-action listener: _resource_record_pre_action 07:35:46 INFO - Running main action method: populate_webroot 07:35:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:35:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:35:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:35:46 INFO - '--tppagecycles', 07:35:46 INFO - '7'], 07:35:46 INFO - 'tests': ['tsvgm']}}, 07:35:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:35:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:35:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:35:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:35:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:35:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:35:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:35:46 INFO - 'talos_options': ['--disable-e10s'], 07:35:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:35:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:35:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:35:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:35:46 INFO - 'talos_options': ['--disable-e10s'], 07:35:46 INFO - 'tests': ['damp', 'tps']}, 07:35:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:35:46 INFO - 'tests': ['damp', 'tps']}, 07:35:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:35:46 INFO - 'tests': ['dromaeo_dom']}, 07:35:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:35:46 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:35:46 INFO - 'tests': ['basic_compositor_video']}, 07:35:46 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:35:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:35:46 INFO - 'tests': ['a11yr', 07:35:46 INFO - 'ts_paint', 07:35:46 INFO - 'tpaint', 07:35:46 INFO - 'sessionrestore', 07:35:46 INFO - 'sessionrestore_no_auto_restore', 07:35:46 INFO - 'tabpaint']}, 07:35:46 INFO - 'other-e10s': {'tests': ['a11yr', 07:35:46 INFO - 'ts_paint', 07:35:46 INFO - 'tpaint', 07:35:46 INFO - 'sessionrestore', 07:35:46 INFO - 'sessionrestore_no_auto_restore', 07:35:46 INFO - 'tabpaint']}, 07:35:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:35:46 INFO - 'ts_paint', 07:35:46 INFO - 'tpaint', 07:35:46 INFO - 'sessionrestore', 07:35:46 INFO - 'sessionrestore_no_auto_restore', 07:35:46 INFO - 'tabpaint']}, 07:35:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:35:46 INFO - 'ts_paint', 07:35:46 INFO - 'tpaint', 07:35:46 INFO - 'sessionrestore', 07:35:46 INFO - 'sessionrestore_no_auto_restore', 07:35:46 INFO - 'tabpaint']}, 07:35:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:35:46 INFO - 'tests': ['a11yr', 07:35:46 INFO - 'ts_paint', 07:35:46 INFO - 'tpaint', 07:35:46 INFO - 'sessionrestore', 07:35:46 INFO - 'sessionrestore_no_auto_restore', 07:35:46 INFO - 'tabpaint']}, 07:35:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:35:46 INFO - 'tests': ['a11yr', 07:35:46 INFO - 'ts_paint', 07:35:46 INFO - 'tpaint', 07:35:46 INFO - 'sessionrestore', 07:35:46 INFO - 'sessionrestore_no_auto_restore', 07:35:46 INFO - 'tabpaint']}, 07:35:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:35:46 INFO - 'tests': ['tsvgx', 07:35:46 INFO - 'tsvgr_opacity', 07:35:46 INFO - 'tart', 07:35:46 INFO - 'tscrollx', 07:35:46 INFO - 'cart']}, 07:35:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:35:46 INFO - 'tsvgr_opacity', 07:35:46 INFO - 'tart', 07:35:46 INFO - 'tscrollx', 07:35:46 INFO - 'cart']}, 07:35:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:35:46 INFO - 'talos_options': ['--disable-e10s'], 07:35:46 INFO - 'tests': ['tp5o']}, 07:35:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:35:46 INFO - 'tests': ['tp5o']}, 07:35:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:35:46 INFO - 'talos_options': ['--disable-e10s', 07:35:46 INFO - '--xperf_path', 07:35:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:35:46 INFO - 'tests': ['tp5n']}, 07:35:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:35:46 INFO - 'talos_options': ['--xperf_path', 07:35:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:35:46 INFO - 'tests': ['tp5n']}}, 07:35:46 INFO - 'talos.zip': {'path': '', 07:35:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:35:46 INFO - Running post-action listener: _resource_record_post_action 07:35:46 INFO - [mozharness: 2016-09-30 14:35:46.961623Z] Finished populate-webroot step (success) 07:35:46 INFO - [mozharness: 2016-09-30 14:35:46.961756Z] Running create-virtualenv step. 07:35:46 INFO - Running pre-action listener: _resource_record_pre_action 07:35:46 INFO - Running main action method: create_virtualenv 07:35:46 INFO - Creating virtualenv /builds/slave/test/build/venv 07:35:46 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 07:35:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:35:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:35:47 INFO - Using real prefix '/tools/python27' 07:35:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:35:47 INFO - Installing distribute.............................................................................................................................................................................................done. 07:35:50 INFO - Installing pip.................done. 07:35:50 INFO - Return code: 0 07:35:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:35:50 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')]} 07:35:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:35:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:50 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')]} 07:35:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:35:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:50 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 0x10f97a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8f0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b69d685d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f78ed30>, '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 0x10f5f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f786b20>, '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.lS1UAURRFT/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.vKD3mPWGrw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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 07:35:50 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 07:35:50 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 07:35:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lS1UAURRFT/Render', 07:35:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:35:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:35:50 INFO - 'HOME': '/Users/cltbld', 07:35:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:35:50 INFO - 'LOGNAME': 'cltbld', 07:35:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:50 INFO - 'MOZ_NO_REMOTE': '1', 07:35:50 INFO - 'NO_EM_RESTART': '1', 07:35:50 INFO - 'PAGER': '/bin/cat', 07:35:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:35:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:50 INFO - 'PWD': '/builds/slave/test', 07:35:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:35:50 INFO - 'SHELL': '/bin/bash', 07:35:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vKD3mPWGrw/Listeners', 07:35:50 INFO - 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/', 07:35:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:35:50 INFO - 'USER': 'cltbld', 07:35:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:35:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:35:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:50 INFO - 'XPC_FLAGS': '0x0', 07:35:50 INFO - 'XPC_SERVICE_NAME': '0', 07:35:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:35:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:35:51 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 07:35:51 INFO - Cleaning up... 07:35:51 INFO - Return code: 0 07:35:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:35:51 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')]} 07:35:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:35:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:51 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')]} 07:35:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:35:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:51 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 0x10f97a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8f0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b69d685d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f78ed30>, '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 0x10f5f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f786b20>, '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.lS1UAURRFT/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.vKD3mPWGrw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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 07:35:51 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 07:35:51 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 07:35:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lS1UAURRFT/Render', 07:35:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:35:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:35:51 INFO - 'HOME': '/Users/cltbld', 07:35:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:35:51 INFO - 'LOGNAME': 'cltbld', 07:35:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:51 INFO - 'MOZ_NO_REMOTE': '1', 07:35:51 INFO - 'NO_EM_RESTART': '1', 07:35:51 INFO - 'PAGER': '/bin/cat', 07:35:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:35:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:51 INFO - 'PWD': '/builds/slave/test', 07:35:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:35:51 INFO - 'SHELL': '/bin/bash', 07:35:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vKD3mPWGrw/Listeners', 07:35:51 INFO - 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/', 07:35:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:35:51 INFO - 'USER': 'cltbld', 07:35:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:35:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:35:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:51 INFO - 'XPC_FLAGS': '0x0', 07:35:51 INFO - 'XPC_SERVICE_NAME': '0', 07:35:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:35:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:35:51 INFO - Downloading/unpacking psutil>=3.1.1 07:35:51 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 07:35:51 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 07:35:51 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 07:35:51 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 07:35:51 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 07:35:51 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 07:35:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:35:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:35:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:35:55 INFO - Installing collected packages: psutil 07:35:55 INFO - Running setup.py install for psutil 07:35:55 INFO - building 'psutil._psutil_osx' extension 07:35:55 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 07:35:55 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 07:35:56 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 07:35:56 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 07:35:56 INFO - building 'psutil._psutil_posix' extension 07:35:56 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 07:35:56 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:35:56 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:35:56 INFO - ^ 07:35:56 INFO - 1 warning generated. 07:35:56 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 07:35:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:35:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:35:56 INFO - Successfully installed psutil 07:35:56 INFO - Cleaning up... 07:35:56 INFO - Return code: 0 07:35:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:35:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:35:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:35:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:35:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:35:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f97a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8f0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b69d685d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f78ed30>, '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 0x10f5f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f786b20>, '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.lS1UAURRFT/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.vKD3mPWGrw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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 07:35:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:35:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:35:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lS1UAURRFT/Render', 07:35:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:35:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:35:56 INFO - 'HOME': '/Users/cltbld', 07:35:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:35:56 INFO - 'LOGNAME': 'cltbld', 07:35:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:56 INFO - 'MOZ_NO_REMOTE': '1', 07:35:56 INFO - 'NO_EM_RESTART': '1', 07:35:56 INFO - 'PAGER': '/bin/cat', 07:35:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:35:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:56 INFO - 'PWD': '/builds/slave/test', 07:35:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:35:56 INFO - 'SHELL': '/bin/bash', 07:35:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vKD3mPWGrw/Listeners', 07:35:56 INFO - 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/', 07:35:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:35:56 INFO - 'USER': 'cltbld', 07:35:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:35:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:35:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:56 INFO - 'XPC_FLAGS': '0x0', 07:35:56 INFO - 'XPC_SERVICE_NAME': '0', 07:35:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:35:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:35:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:35:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:35:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:35:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:35:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:35:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:35:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:35:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:35:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:35:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:35:59 INFO - Installing collected packages: mozsystemmonitor 07:35:59 INFO - Running setup.py install for mozsystemmonitor 07:35:59 INFO - Successfully installed mozsystemmonitor 07:35:59 INFO - Cleaning up... 07:35:59 INFO - Return code: 0 07:35:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:35:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:35:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:35:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:35:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:35:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10f97a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8f0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b69d685d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f78ed30>, '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 0x10f5f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f786b20>, '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.lS1UAURRFT/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.vKD3mPWGrw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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 07:35:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:35:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:35:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lS1UAURRFT/Render', 07:35:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:35:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:35:59 INFO - 'HOME': '/Users/cltbld', 07:35:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:35:59 INFO - 'LOGNAME': 'cltbld', 07:35:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:59 INFO - 'MOZ_NO_REMOTE': '1', 07:35:59 INFO - 'NO_EM_RESTART': '1', 07:35:59 INFO - 'PAGER': '/bin/cat', 07:35:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:35:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:59 INFO - 'PWD': '/builds/slave/test', 07:35:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:35:59 INFO - 'SHELL': '/bin/bash', 07:35:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vKD3mPWGrw/Listeners', 07:35:59 INFO - 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/', 07:35:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:35:59 INFO - 'USER': 'cltbld', 07:35:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:35:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:35:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:59 INFO - 'XPC_FLAGS': '0x0', 07:35:59 INFO - 'XPC_SERVICE_NAME': '0', 07:35:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:35:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:35:59 INFO - Downloading/unpacking jsonschema==2.5.1 07:35:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:35:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:35:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:35:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:35:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:35:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:36:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:36:02 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 07:36:02 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 07:36:02 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 07:36:02 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 07:36:02 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 07:36:02 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 07:36:02 INFO - Downloading functools32-3.2.3-2.tar.gz 07:36:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:36:02 INFO - warning: no files found matching '*.txt' 07:36:02 INFO - no previously-included directories found matching 'build' 07:36:02 INFO - no previously-included directories found matching 'dist' 07:36:02 INFO - no previously-included directories found matching '.git*' 07:36:02 INFO - Installing collected packages: jsonschema, functools32 07:36:02 INFO - Running setup.py install for functools32 07:36:03 INFO - warning: no files found matching '*.txt' 07:36:03 INFO - no previously-included directories found matching 'build' 07:36:03 INFO - no previously-included directories found matching 'dist' 07:36:03 INFO - no previously-included directories found matching '.git*' 07:36:03 INFO - Successfully installed jsonschema functools32 07:36:03 INFO - Cleaning up... 07:36:03 INFO - Return code: 0 07:36:03 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:36:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10f97a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8f0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b69d685d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f78ed30>, '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 0x10f5f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f786b20>, '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.lS1UAURRFT/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.vKD3mPWGrw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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 07:36:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:36:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:36:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lS1UAURRFT/Render', 07:36:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:36:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:36:03 INFO - 'HOME': '/Users/cltbld', 07:36:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:36:03 INFO - 'LOGNAME': 'cltbld', 07:36:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:03 INFO - 'MOZ_NO_REMOTE': '1', 07:36:03 INFO - 'NO_EM_RESTART': '1', 07:36:03 INFO - 'PAGER': '/bin/cat', 07:36:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:36:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:03 INFO - 'PWD': '/builds/slave/test', 07:36:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:36:03 INFO - 'SHELL': '/bin/bash', 07:36:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vKD3mPWGrw/Listeners', 07:36:03 INFO - 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/', 07:36:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:36:03 INFO - 'USER': 'cltbld', 07:36:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:36:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:36:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:03 INFO - 'XPC_FLAGS': '0x0', 07:36:03 INFO - 'XPC_SERVICE_NAME': '0', 07:36:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:36:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:03 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:36:03 INFO - Cleaning up... 07:36:03 INFO - Return code: 0 07:36:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:36:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10f97a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8f0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b69d685d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f78ed30>, '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 0x10f5f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f786b20>, '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.lS1UAURRFT/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.vKD3mPWGrw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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 07:36:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:36:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:36:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lS1UAURRFT/Render', 07:36:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:36:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:36:03 INFO - 'HOME': '/Users/cltbld', 07:36:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:36:03 INFO - 'LOGNAME': 'cltbld', 07:36:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:03 INFO - 'MOZ_NO_REMOTE': '1', 07:36:03 INFO - 'NO_EM_RESTART': '1', 07:36:03 INFO - 'PAGER': '/bin/cat', 07:36:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:36:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:03 INFO - 'PWD': '/builds/slave/test', 07:36:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:36:03 INFO - 'SHELL': '/bin/bash', 07:36:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vKD3mPWGrw/Listeners', 07:36:03 INFO - 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/', 07:36:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:36:03 INFO - 'USER': 'cltbld', 07:36:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:36:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:36:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:03 INFO - 'XPC_FLAGS': '0x0', 07:36:03 INFO - 'XPC_SERVICE_NAME': '0', 07:36:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:36:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:03 INFO - Downloading/unpacking blobuploader==1.2.4 07:36:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:06 INFO - Downloading blobuploader-1.2.4.tar.gz 07:36:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:36:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:36:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:36:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:36:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:07 INFO - Downloading docopt-0.6.1.tar.gz 07:36:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:36:07 INFO - Installing collected packages: blobuploader, requests, docopt 07:36:07 INFO - Running setup.py install for blobuploader 07:36:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:36:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:36:07 INFO - Running setup.py install for requests 07:36:08 INFO - Running setup.py install for docopt 07:36:08 INFO - Successfully installed blobuploader requests docopt 07:36:08 INFO - Cleaning up... 07:36:08 INFO - Return code: 0 07:36:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:36:08 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')]} 07:36:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:08 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')]} 07:36:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:08 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 0x10f97a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8f0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b69d685d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f78ed30>, '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 0x10f5f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f786b20>, '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.lS1UAURRFT/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.vKD3mPWGrw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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 07:36:08 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 07:36:08 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 07:36:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lS1UAURRFT/Render', 07:36:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:36:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:36:08 INFO - 'HOME': '/Users/cltbld', 07:36:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:36:08 INFO - 'LOGNAME': 'cltbld', 07:36:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:08 INFO - 'MOZ_NO_REMOTE': '1', 07:36:08 INFO - 'NO_EM_RESTART': '1', 07:36:08 INFO - 'PAGER': '/bin/cat', 07:36:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:36:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:08 INFO - 'PWD': '/builds/slave/test', 07:36:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:36:08 INFO - 'SHELL': '/bin/bash', 07:36:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vKD3mPWGrw/Listeners', 07:36:08 INFO - 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/', 07:36:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:36:08 INFO - 'USER': 'cltbld', 07:36:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:36:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:36:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:08 INFO - 'XPC_FLAGS': '0x0', 07:36:08 INFO - 'XPC_SERVICE_NAME': '0', 07:36:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:36:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:36:08 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-JSQ6d4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:36:08 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-nXen21-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:36:08 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-wgD1Da-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:36:08 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-EGBRX1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:36:08 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-ZWAhkR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:36:09 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-E6ahDp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:36:09 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-G060pc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:36:09 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-eAEYH1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:36:09 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-64SW0M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:36:09 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-uAsdR5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:36:09 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-keXLDP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:36:09 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-SKEwdv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:36:09 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-tPjfwe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:36:09 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-93fDkJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:36:10 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-HCKtrz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:36:10 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-Hz4KFx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:36:10 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-3sbZkg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:36:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:36:10 INFO - Running setup.py install for manifestparser 07:36:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:36:10 INFO - Running setup.py install for mozcrash 07:36:10 INFO - Running setup.py install for mozdebug 07:36:10 INFO - Running setup.py install for mozdevice 07:36:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:36:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:36:10 INFO - Running setup.py install for mozfile 07:36:11 INFO - Running setup.py install for mozhttpd 07:36:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:36:11 INFO - Running setup.py install for mozinfo 07:36:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:36:11 INFO - Running setup.py install for mozInstall 07:36:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:36:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:36:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:36:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:36:11 INFO - Running setup.py install for mozleak 07:36:11 INFO - Running setup.py install for mozlog 07:36:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:36:11 INFO - Running setup.py install for moznetwork 07:36:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:36:11 INFO - Running setup.py install for mozprocess 07:36:12 INFO - Running setup.py install for mozprofile 07:36:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:36:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:36:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:36:12 INFO - Running setup.py install for mozrunner 07:36:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:36:12 INFO - Running setup.py install for mozscreenshot 07:36:12 INFO - Running setup.py install for moztest 07:36:12 INFO - Running setup.py install for mozversion 07:36:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:36:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:36:12 INFO - Cleaning up... 07:36:12 INFO - Return code: 0 07:36:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:36:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:12 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 0x10f97a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8f0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b69d685d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f78ed30>, '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 0x10f5f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f786b20>, '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.lS1UAURRFT/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.vKD3mPWGrw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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 07:36:12 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 07:36:12 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 07:36:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lS1UAURRFT/Render', 07:36:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:36:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:36:12 INFO - 'HOME': '/Users/cltbld', 07:36:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:36:12 INFO - 'LOGNAME': 'cltbld', 07:36:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:12 INFO - 'MOZ_NO_REMOTE': '1', 07:36:12 INFO - 'NO_EM_RESTART': '1', 07:36:12 INFO - 'PAGER': '/bin/cat', 07:36:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:36:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:12 INFO - 'PWD': '/builds/slave/test', 07:36:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:36:12 INFO - 'SHELL': '/bin/bash', 07:36:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vKD3mPWGrw/Listeners', 07:36:12 INFO - 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/', 07:36:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:36:12 INFO - 'USER': 'cltbld', 07:36:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:36:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:36:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:12 INFO - 'XPC_FLAGS': '0x0', 07:36:12 INFO - 'XPC_SERVICE_NAME': '0', 07:36:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:36:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:36:13 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-WyEgZx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:36:13 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)) 07:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:36:13 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-IQxthg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:36:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 07:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:36:13 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-bEhoRP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:36:13 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)) 07:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:36:13 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-l0F3Ht-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:36:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 07:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:36:13 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-GUzkBq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:36:13 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)) 07:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:36:13 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-fEHZYN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:36:13 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)) 07:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:36:13 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-P7QZ_x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:36:13 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)) 07:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:36:13 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-37wUjX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:36:14 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)) 07:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:36:14 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-PZajhv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:36:14 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)) 07:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:36:14 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-ObET_t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:36:14 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)) 07:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:36:14 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-I7tQiM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:36:14 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)) 07:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:36:14 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-mJkppI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:36:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 07:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:36:14 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-SfuIx0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:36:14 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)) 07:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:36:14 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-xeFRhL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:36:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 07:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:36:14 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-Ncqdq_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:36:14 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)) 07:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:36:14 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-Eu3ynr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:36:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 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)) 07:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:36:14 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-dxcR_d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:36:15 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)) 07:36:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:36:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:36:15 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)) 07:36:15 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:36:15 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:36:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:36:15 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 07:36:15 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 07:36:15 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 07:36:15 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 07:36:15 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 07:36:15 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 07:36:17 INFO - Downloading blessings-1.6.tar.gz 07:36:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:36:17 INFO - Installing collected packages: blessings 07:36:17 INFO - Running setup.py install for blessings 07:36:17 INFO - Successfully installed blessings 07:36:17 INFO - Cleaning up... 07:36:17 INFO - Return code: 0 07:36:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:36:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:36:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:36:18 INFO - Reading from file tmpfile_stdout 07:36:18 INFO - Current package versions: 07:36:18 INFO - blessings == 1.6 07:36:18 INFO - blobuploader == 1.2.4 07:36:18 INFO - docopt == 0.6.1 07:36:18 INFO - functools32 == 3.2.3-2 07:36:18 INFO - jsonschema == 2.5.1 07:36:18 INFO - manifestparser == 1.1 07:36:18 INFO - mozInstall == 1.12 07:36:18 INFO - mozcrash == 0.17 07:36:18 INFO - mozdebug == 0.1 07:36:18 INFO - mozdevice == 0.48 07:36:18 INFO - mozfile == 1.2 07:36:18 INFO - mozhttpd == 0.7 07:36:18 INFO - mozinfo == 0.9 07:36:18 INFO - mozleak == 0.1 07:36:18 INFO - mozlog == 3.4 07:36:18 INFO - moznetwork == 0.27 07:36:18 INFO - mozprocess == 0.23 07:36:18 INFO - mozprofile == 0.28 07:36:18 INFO - mozrunner == 6.12 07:36:18 INFO - mozscreenshot == 0.1 07:36:18 INFO - mozsystemmonitor == 0.3 07:36:18 INFO - moztest == 0.7 07:36:18 INFO - mozversion == 1.4 07:36:18 INFO - psutil == 3.1.1 07:36:18 INFO - requests == 1.2.3 07:36:18 INFO - wsgiref == 0.1.2 07:36:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:36:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:18 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 0x10f97a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8f0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b69d685d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f78ed30>, '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 0x10f5f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f786b20>, '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.lS1UAURRFT/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.vKD3mPWGrw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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 07:36:18 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 07:36:18 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 07:36:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lS1UAURRFT/Render', 07:36:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:36:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:36:18 INFO - 'HOME': '/Users/cltbld', 07:36:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:36:18 INFO - 'LOGNAME': 'cltbld', 07:36:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:18 INFO - 'MOZ_NO_REMOTE': '1', 07:36:18 INFO - 'NO_EM_RESTART': '1', 07:36:18 INFO - 'PAGER': '/bin/cat', 07:36:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:36:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:18 INFO - 'PWD': '/builds/slave/test', 07:36:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:36:18 INFO - 'SHELL': '/bin/bash', 07:36:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vKD3mPWGrw/Listeners', 07:36:18 INFO - 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/', 07:36:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:36:18 INFO - 'USER': 'cltbld', 07:36:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:36:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:36:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:18 INFO - 'XPC_FLAGS': '0x0', 07:36:18 INFO - 'XPC_SERVICE_NAME': '0', 07:36:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:36:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:18 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)) 07:36:18 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)) 07:36:18 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)) 07:36:18 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)) 07:36:18 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)) 07:36:18 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)) 07:36:18 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)) 07:36:18 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)) 07:36:18 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)) 07:36:18 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)) 07:36:18 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)) 07:36:18 INFO - Cleaning up... 07:36:18 INFO - Return code: 0 07:36:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:36:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:18 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 0x10f97a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8f0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b69d685d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f78ed30>, '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 0x10f5f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f786b20>, '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.lS1UAURRFT/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.vKD3mPWGrw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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 07:36:18 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 07:36:18 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 07:36:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lS1UAURRFT/Render', 07:36:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:36:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:36:18 INFO - 'HOME': '/Users/cltbld', 07:36:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:36:18 INFO - 'LOGNAME': 'cltbld', 07:36:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:18 INFO - 'MOZ_NO_REMOTE': '1', 07:36:18 INFO - 'NO_EM_RESTART': '1', 07:36:18 INFO - 'PAGER': '/bin/cat', 07:36:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:36:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:18 INFO - 'PWD': '/builds/slave/test', 07:36:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:36:18 INFO - 'SHELL': '/bin/bash', 07:36:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vKD3mPWGrw/Listeners', 07:36:18 INFO - 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/', 07:36:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:36:18 INFO - 'USER': 'cltbld', 07:36:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:36:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:36:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:18 INFO - 'XPC_FLAGS': '0x0', 07:36:18 INFO - 'XPC_SERVICE_NAME': '0', 07:36:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:36:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:18 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:36:18 INFO - Cleaning up... 07:36:18 INFO - Return code: 0 07:36:18 INFO - Running post-action listener: _resource_record_post_action 07:36:18 INFO - Running post-action listener: _start_resource_monitoring 07:36:18 INFO - Starting resource monitoring. 07:36:18 INFO - [mozharness: 2016-09-30 14:36:18.664341Z] Finished create-virtualenv step (success) 07:36:18 INFO - [mozharness: 2016-09-30 14:36:18.665361Z] Running install step. 07:36:18 INFO - Running pre-action listener: _resource_record_pre_action 07:36:18 INFO - Running main action method: install 07:36:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:36:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:36:18 INFO - Reading from file tmpfile_stdout 07:36:18 INFO - Detecting whether we're running mozinstall >=1.0... 07:36:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:36:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:36:19 INFO - Reading from file tmpfile_stdout 07:36:19 INFO - Output received: 07:36:19 INFO - Usage: mozinstall [options] installer 07:36:19 INFO - Options: 07:36:19 INFO - -h, --help show this help message and exit 07:36:19 INFO - -d DEST, --destination=DEST 07:36:19 INFO - Directory to install application into. [default: 07:36:19 INFO - "/builds/slave/test"] 07:36:19 INFO - --app=APP Application being installed. [default: firefox] 07:36:19 INFO - mkdir: /builds/slave/test/build/application 07:36:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 07:36:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 07:36:50 INFO - Reading from file tmpfile_stdout 07:36:50 INFO - Output received: 07:36:50 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 07:36:50 INFO - Running post-action listener: _resource_record_post_action 07:36:50 INFO - [mozharness: 2016-09-30 14:36:50.837449Z] Finished install step (success) 07:36:50 INFO - [mozharness: 2016-09-30 14:36:50.837608Z] Running run-tests step. 07:36:50 INFO - Running pre-action listener: _resource_record_pre_action 07:36:50 INFO - Running main action method: run_tests 07:36:50 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:36:50 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:36:50 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:36:50 INFO - 2016-09-30 07:36:50.852 screenresolution[1651:8188] starting screenresolution argv=screenresolution get 07:36:50 INFO - 2016-09-30 07:36:50.854 screenresolution[1651:8188] Display 0: 1600x1200x32@60 07:36:50 INFO - 2016-09-30 07:36:50.860 screenresolution[1652:8190] starting screenresolution argv=screenresolution list 07:36:50 INFO - Available Modes on Display 0 07:36:50 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:36:50 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:36:50 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:36:50 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:36:51 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:36:51 INFO - Intel Iris: 07:36:51 INFO - Chipset Model: Intel Iris 07:36:51 INFO - Type: GPU 07:36:51 INFO - Bus: Built-In 07:36:51 INFO - VRAM (Dynamic, Max): 1536 MB 07:36:51 INFO - Vendor: Intel (0x8086) 07:36:51 INFO - Device ID: 0x0a2e 07:36:51 INFO - Revision ID: 0x0009 07:36:51 INFO - Displays: 07:36:51 INFO - Display: 07:36:51 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:36:51 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:36:51 INFO - Display Serial Number: 1600x1200 60 07:36:51 INFO - Main Display: Yes 07:36:51 INFO - Mirror: Off 07:36:51 INFO - Online: Yes 07:36:51 INFO - Rotation: Supported 07:36:51 INFO - Return code: 0 07:36:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:36:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:36:51 INFO - Python 2.7.3 07:36:51 INFO - Return code: 0 07:36:51 INFO - grabbing minidump binary from tooltool 07:36:51 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')]} 07:36:51 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 0x10f78ed30>, '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 0x10f5f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f786b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:36:51 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 07:36:51 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 07:36:51 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 07:36:51 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:36:51 INFO - Return code: 0 07:36:51 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:36:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:36:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:36:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:36:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:36:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0087', '--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 07:36:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0087 --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 07:36:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lS1UAURRFT/Render', 07:36:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:36:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:36:51 INFO - 'HOME': '/Users/cltbld', 07:36:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:36:51 INFO - 'LOGNAME': 'cltbld', 07:36:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:36:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:36:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:51 INFO - 'MOZ_NO_REMOTE': '1', 07:36:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:36:51 INFO - 'NO_EM_RESTART': '1', 07:36:51 INFO - 'PAGER': '/bin/cat', 07:36:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:36:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:51 INFO - 'PWD': '/builds/slave/test', 07:36:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:36:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:36:51 INFO - 'SHELL': '/bin/bash', 07:36:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vKD3mPWGrw/Listeners', 07:36:51 INFO - 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/', 07:36:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:36:51 INFO - 'USER': 'cltbld', 07:36:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:36:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:36:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:51 INFO - 'XPC_FLAGS': '0x0', 07:36:51 INFO - 'XPC_SERVICE_NAME': '0', 07:36:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:36:51 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0087', '--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 07:36:51 INFO - mozversion application_buildid: 20160930013320 07:36:51 INFO - mozversion application_changeset: 805d5fc3d66c4fa585a3de407b1e0b055f78eb58 07:36:51 INFO - mozversion application_display_name: FirefoxDeveloperEdition 07:36:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:36:51 INFO - mozversion application_name: Firefox 07:36:51 INFO - mozversion application_remotingname: firefox-dev 07:36:51 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:36:51 INFO - mozversion application_vendor: Mozilla 07:36:51 INFO - mozversion application_version: 51.0a2 07:36:51 INFO - mozversion platform_buildid: 20160930013320 07:36:51 INFO - mozversion platform_changeset: 805d5fc3d66c4fa585a3de407b1e0b055f78eb58 07:36:51 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:36:51 INFO - mozversion platform_version: 51.0a2 07:36:51 INFO - using testdate: 1475246211 07:36:51 INFO - actual date: 1475246211 07:36:51 INFO - starting webserver on 'localhost:49278' 07:36:51 INFO - SUITE-START | Running 2 tests 07:36:51 INFO - TEST-START | dromaeo_css 07:36:51 INFO - operating with platform_type : mac_ 07:36:51 INFO - Initialising browser for dromaeo_css test... 07:36:51 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/tmpYEOU8b/profile http://localhost:49278/getInfo.html) 07:36:53 INFO - PROCESS | 1662 | __metrics Screen width/height:1600/1200 07:36:53 INFO - PROCESS | 1662 | colorDepth:24 07:36:53 INFO - PROCESS | 1662 | Browser inner width/height: 1024/689 07:36:53 INFO - PROCESS | 1662 | __metrics 07:36:54 INFO - PROCESS | 1662 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:36:54 INFO - PROCESS | 1662 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:36:54 INFO - TEST-INFO | 1662: exit 0 07:36:54 INFO - Browser initialized. 07:36:54 INFO - Running cycle 1/1 for dromaeo_css test... 07:36:54 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/tmpYEOU8b/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:37:07 INFO - PROCESS | 1665 | RSS: Main: 219201536 07:37:07 INFO - PROCESS | 1665 | 07:37:58 INFO - PROCESS | 1665 | 1475246278875 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 07:40:10 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49278/tests/dromaeo/cssquery-ext.html) 07:40:12 INFO - PROCESS | 1665 | RSS: Main: 383221760 07:40:12 INFO - PROCESS | 1665 | 07:43:15 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-ext.html (next: http://localhost:49278/tests/dromaeo/cssquery-jquery.html) 07:43:15 INFO - PROCESS | 1665 | RSS: Main: 354340864 07:43:15 INFO - PROCESS | 1665 | 07:46:18 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49278/tests/dromaeo/cssquery-mootools.html) 07:46:18 INFO - PROCESS | 1665 | RSS: Main: 318582784 07:46:18 INFO - PROCESS | 1665 | 07:49:21 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49278/tests/dromaeo/cssquery-prototype.html) 07:49:21 INFO - PROCESS | 1665 | RSS: Main: 341848064 07:49:21 INFO - PROCESS | 1665 | 07:52:24 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49278/tests/dromaeo/cssquery-yui.html) 07:52:25 INFO - PROCESS | 1665 | RSS: Main: 310165504 07:52:25 INFO - PROCESS | 1665 | 07:55:28 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-yui.html (next: http://localhost:49278/tests/dromaeo/cssquery-dojo.html) 07:55:28 INFO - PROCESS | 1665 | RSS: Main: 475160576 07:55:28 INFO - PROCESS | 1665 | 07:55:28 INFO - PROCESS | 1665 | __start_tp_report 07:55:28 INFO - PROCESS | 1665 | _x_x_mozilla_page_load 07:55:28 INFO - PROCESS | 1665 | _x_x_mozilla_page_load_details 07:55:28 INFO - PROCESS | 1665 | |i|pagename|runs| 07:55:28 INFO - PROCESS | 1665 | |0;dojo.html;3330.2007518195633;3352.7653064285496;3367.898963031107;3384.103212648647;3412;5691.174779656947;5741.224934633823;5743.9138412923785;5755.4244575542425;5760.107183386572;5681.943180568193;5769;5772.134179873021;5782.768689252435;5788.82633520994;5195.168772996321;5254.789808407659;5261.289725886994;5263.0526505229045;5300.416954135042;5178.456262092483;5189.481051894818;5319.255304257388;5336.332958380202;5340.519353258206;5238.816641417551;5280.577553795687;5288.021715982555;5297.073012222865;5298.814541491049;5275.865688876891;5277.841664750044;5285.894282114375;5290.418054014055;5293.364796224478;4252.9149417011795;5106.463821298785;5186.844394668166;5188.870278243074;5231.738413079369;5749.626274292199;5750.424957504216;5799.768009279624;5803.042497987827;5807.796727114573;6231.87536249277;6268.905966410507;6274.466670333027;6282.434580887742;6299.748010079591;6146.969265153691;6148.292946311142;6191.9690401547705;6216.254049514042;6256.5307601930035;5757.913631295534;5813.389594092601;5832.679202643895;5846.853828654318;5855.473007429352;6276.811695649138;6281.811545653638;6286.15136956505;6287.874242515124;6300.873982520324;5002.324686167393;6043.365446628129;6111.022236442237;6131.233595800525;6214.4407003369915;5005.974970125126;6244.968775156095;6254.874902501924;6269.153664255267;6274.121622972787;6188.257409110845;6233.688315584202;6242.875142497124;6257.43683068526;6260.686965651699;6063.514918806573;6105.308121371101;6108.63890615289;6113.755449781959;6126.914660831478;4916.729579873141;4932.4081110267;4948.752562371939;4952.059108769322;4978.751062446936;4447.310666846644;4451.376807246988;4470.173017991682;4488.977555112268;4516.435445569304;5887.882242355129;5919.970400147971;5944.7324870380935;5945.821625351246;5958.897603943197;6125.084128922883;6137.070562331885;6155.907661385083;6196.628202307876;6271.153394291803;5847.678377689268;5905.734241959122;5923.7926672566255;5926.170336152942;5950.523958083343;5460.044492213847;5460.672359658433;5461.453854614507;5471.945280547144;5475.698836563947;6168.969155154375;6250.124982502362;6311.684415779101;6315.5894866833505;6383.234011918599;6120.508083830795;6187.474064704551;6200.81397558074;6202.503799696104;6203.379662033941;6335.968320158369;6367;6371.872562548816;6377.266614339411;6391.776287829904;6065.302490213506;6116.29662588808;6150.384961503813;6157.1072194532435;6171.506279497539;6109.725062372293;6135.93706321624;6148.1699970503405;6204.906926396017;6206.472449841814;6082.3613520581475;6160.876782464416;6170.660613666291;6182.1345011697495;6183.4125758054715;6024.969875150597;6144.938550614436;6151.415615516519;6152.569320147547;6155.815325540241;5661.553809701958;5855.502282306052;6073.605215660968;6074.3318234994995;6100.298465676504;5143.665661731976;5815.476607105381;5971.492423144082;5975.954208013667;6068.271807383142;5806.506446952057;5846.181534585076;5856.180134781049;5859.648421094748;5870.911936320873 07:55:28 INFO - PROCESS | 1665 | |1;ext.html;517.9171332586785;524.6537285391643;533.519832151064;534.8903474787667;554.9999999999999;28116.85941570292;31057.91297304592;32201.67798322016;32258.838705806436;39812.20375592494;40267.798661006724;42668;42707.359389609184;42729;42736.35895461563;9743.464109473995;9859.457729824857;9879.061489158554;9914.603415863357;9924.15644670204;8840.602172902234;9024.819503609924;9776.120149186607;9925;11967.760644787142;12022;12272.570460033901;12277.894989450948;12317.076219283545;12323.568675096374;10160.339577927449;12258.20321679088;12264.877351226463;12271.509139634403;12272.754544909096;8810.515421651806;8973.730788076367;8995.415298005608;9146.131117543822;12118.333491657955;39388.40917386241;39487.80256098701;39679.008024799325;42029.36955945663;42040.36939445911;3140.905772826819;3449.344624521333;3451.36149812283;3504.0714210734177;3812.1994381179984;28359.007434739684;29681.961131360516;29687.81248750069;30168.396632067455;30953.380932381453;3291.210109573709;3312.9834350828332;3317.9004629861142;3424.2124311408515;3434.7767395119236;499965.9999999964;503519;503601;503606;504480;58862.822743544886;59176;59178.11232831511;59224.7038764812;59268.11097833536;62428;62448.687756561834;62509.68745156245;62587.6870615644;62605.373946259955;16132.67734645324;16623.168841558116;16629.002259864446;16638.75041874373;16638.91847029939;12935.741285174245;12972.870271297355;12994.025448091432;13008.349582520836;13009.284489353176;14118.929405353112;14355;14403;15858.762118568231;16253.10607916576;6086.630508135722;6730.360615741497;6923.826904327432;6991.475639327071;7005.404540614003;869.7347309070668;952.7237101240701;959.6113574002541;1030.4126647810676;1064.9414282214552;28779.424411511653;29583;29602.555961660593;30090;30469;1055.0616532955682;1146.3179408252076;1184.9407529623657;1202.7053371923935;1262.3246563088703;14948.850511494746;15451.84548154504;15658.843411565738;15754.448594299145;15764.52857128694;685592;692357;692515;692983;693697;57320.14019789707;57454.42545574491;57512.712436438385;57585.712071439375;57641;1381.2058066611537;1400.4678222275675;1416.3980308368903;1417.397606017459;1420.1195258939317;28871.278218044718;29214.70785292205;29574.704252958054;29683.851580741957;30270.091897243117;49182.77043073952;49381.75309123431;49395.75302123466;49398.753006234736;49453.50546494633;562526;564036;564517;564965;565574;40152.99235038178;40247.597524024386;40595.39106913458;41334.1733165329;41386.172276554906;38385.616143838204;38632.227355452174;41221.58778412177;44717.329240060775;46576.53423465722;34647;38533;39121.82634520969;39500.604993949695;40937.385939211534;30849.845750771103;39050.41424378694;39077.41383879187;39690.60309396985;40607.796961015;37637.623623763415;38164.809175953946;38573;38902.610973889896;38978;34069.659303406646;34368.17402518199;34632.480512792834;34854.82572587222;34974.82512587421;21348.573028539653;21969.780302196774;25645.487090258463;25959.870200648875;26353.341166470225 07:55:28 INFO - PROCESS | 1665 | |2;jquery.html;352.279588242045;353.5174486825483;368.88564544991056;381.57454438301295;401.3658419696877;14875.702485950287;15043.623909402271;15850.716546705562;20887.582248355026;20908;19047.333343332986;19710.70433943492;20157.39527814164;20324.187032518683;20735.792642073575;5685.687287199213;5734.299829354077;5940.673262970535;5951.256092988377;5954.106883967418;4431.578999994996;5820.621659592134;5889.85275368115;5897.115432685088;5902.675352855591;5535.501804837564;5830.300363956331;5834.5040671542965;5840.299164100314;5858.209141765849;5723.399043100477;5861.736221870026;5875.735591898332;5877.382874798127;5880.2355693759755;5505.697186654733;5661.631993920382;5694;5698.658080515141;5741.741621627037;12785.232886026775;13007.089503734742;13019.349032548334;13021.218726876417;23821;2175.423512769117;2381.297517232403;2420.455397535558;2724.0465836957105;2783.7633801126726;9215.677451289239;9991.950040249752;10183.236257280734;11606;15411.22943852803;1765.7704498415253;1828.7531183290218;1879.1543805287674;1895.3650527073446;1908.1318000309825;104896.95103049025;121488;129101;136457;138682.3065884674;8761.386702930733;11062.170337224741;11577.594784182513;11596.01433878113;11782.52869885195;14533.418663253562;14557.908156888276;14564.41742330295;14577.41690332396;14585.92707036458;8275.337972962148;8495.490270583785;8538.231559159705;8613.870791938127;8683.652653893774;8351.874721879176;8481.363897707573;8511.319094472427;8661.393702440895;8677.78716427307;3692.538432695913;3777.905552361213;4369.584889435499;4374.059577190919;4451.176532341462;1841.5948491332153;1877.568159323336;1880.7837098733821;1881.9529511762316;1892.687706528435;738.5421038955882;847.2713466418875;861.5476874640864;960.159860122393;997.8702768640176;20123.698144527843;20271.695924561143;21365.25221617236;21417;21463.248786292406;904.7828521155008;942.2509105261333;945.7399215215871;953.1183655118987;1008.4050410257836;10546.050855422895;10733.677989660166;11836.349000804867;12179.939100304442;12268.754624907451;626996.4804441526;632451;636047;648614;649608;139032.7482940487;139444;143220;148047;150740;431.3357429558508;455.04894769931;457.46476622352594;849.6006876767909;876.8816209811721;10768.784624307627;10816.4050977197;10944.562217511211;10956.835647465454;11435.828462573234;51834.481655182964;52947.73526132345;55530.61173470695;55847.162292566456;56022.71988640031;76383;77990.9926571674;80452.19547804446;80759.59620202097;83299.91750206293;8109.134898973151;8132.715354962548;8301.501909885426;8412.495250285003;8465.492070475791;8867.778305542155;12884.226946383247;12981.728197565199;13215.60353189406;13562.525311614047;10979.804039192033;11022.834657480305;11066.170037247077;11170.385628790495;11401.942990284995;9442.622295108118;10734.892651073702;10774.784504310026;11431.314121152758;11444.542218311175;10911.836322455329;11196.272242304223;11420.771584568429;11446.656600302003;11638.010769084724;8009.478199142144;8012.83974320522;8056.637451314587;8260.958695206486;8377.916220837957;7975.521468711896;8375.41372103947;10476.323788193853;10829.24195306321;10991.725206869893 07:55:28 INFO - PROCESS | 1665 | |3;mootools.html;1358.2122369025965;1515.57563882113;1534.7467667834803;1748.8338607832259;1918.6642337590918;7150.928490715098;7990.640421181046;8539.658413663454;9036.77408064797;9038.322125840572;8923;9010.68462603809;9016.188543031127;9017.143371379725;9018.188363047324;2389.7729715676983;2426.259990702835;2427.6237183236626;2427.8057755379527;2436.5735996200683;2376.702912135983;2413.2760171948435;2424.0425032112307;2424.212131057405;2426.0538390027905;2388.152205966883;2396.436837343223;2407.6749638798715;2414.6619473273754;2425.50277193175;2365.042157926043;2383.8808059597036;2392.306231192952;2397.0531640002278;2406.4585468269674;2246.663235374949;2272.193371353179;2276.7723227677266;2280.8061314788265;2282.0643536150264;8840.955795220983;8994.145556172152;9010.369274150811;9020.458772473607;9030.232430243437;5271.920921186185;5472;5481.780728770885;5484.204790305424;5503.972480137613;3570.785752854811;3607.603163651996;3638.5815631202486;3677.117491801975;3686.5207523022104;1096.572336788653;1099.4942326529726;1102.090775110537;1115.7880002799443;1125.291066628019;12020.398980050963;12025.037996960222;12112.21270617416;12144.939275303566;12156.696082598006;3690.55713314404;4039.9698076990767;4455.465344158657;4734.337192793012;4761.095391875532;9428.292878034175;9429.528523573794;9435.764105897408;9437.103475169848;9461.05389461062;5239.554637855748;5334.67991920486;5362.51737343641;5363.624546281723;5365.892682146336;4240.893977650583;4500.144972455223;4643.2802915548145;4648.209804333272;5039.647224694309;3872.6708229800784;3938.6258305460933;3996.1008773025837;4002.2195671844293;4019.135885784512;1184.6979020349756;1192.3680449361852;1194.3908606610692;1205.4635687119148;1207.3480320626938;713.4969846258375;811.2090711556185;848.5969164646867;942.6512190489562;953.2945620240972;5759.769609215668;5856.238688970492;5882.823435312955;6020.337762846083;6261.843453913598;942.8679984802134;943.8112377524523;948.6529128637213;962.3888830592484;976.4824642939253;3838.3666694995013;3918.3730603103936;3976.4035394691027;4010.4184893190322;4024.5371782245415;8871;9257.259419246444;11122.943320384551;11299.717507062389;11333.489992950337;9170.495622740813;11074.446277686084;11261.774764504664;11263.49314280843;11287.322760634388;7867.252611001945;8234.217749313926;8262.091169971298;8350.4154709171;8353.582320883932;5972.163897054329;6019.127226552213;6028.517718582415;6116.877662446637;6194.008958566607;10038.799224015333;10301.433421161908;10467;10486.895131048592;10490.423026733602;10256.12822910061;10424;10609.469526523797;10699.679009629723;10706.411147386969;7586.24137586237;7662.157162712208;7731.420143489373;7732.690692372242;7734.92265077342;8130.75607731769;8215.383846211438;8314.251717345467;8327.084020757833;8332.875006875023;7362;7522.736704215326;7609.124950630527;7628.313451789366;7670.424718146273;7465.216152304147;7505.024346835095;7509.324160825552;7565.583892885944;7571.886421703789;6946.444284457332;7074.080369551925;7162.355388015104;7260.4554658399775;7263.4915555910575;5100.928804951001;5101.336826212569;5128.102582048201;5132.10188217053;5153.510416510426;4747.098051370229;4901.289313049517;4955.677880937727;5079.11115554769;5165.380154381498 07:55:28 INFO - PROCESS | 1665 | |4;prototype.html;286.1686799846446;290.32644265304504;291.84094668405703;302.7154474793694;308.2663261437778;4180.745776267123;4571.542845715427;5118.769655365508;5328.49379308966;5390.5418039466695;4001.419084690373;4776.164171270023;5181.119209734345;5257.36911570612;5261.711430356027;3384;4049.6962727795385;4065.79671016448;4119.732217405859;4135.524414692311;3172.6034245719284;3766.8869933901888;4073.5111786585503;4116.242117781094;4123.938030984507;3580.8004318553317;3946.6645335146545;3966.52401711795;3997.2005598880196;4024.5774193709676;3534.063473179584;3632.5469812075116;3716.513394642151;3729.4778730977687;3978.5026871641044;3416.197193659488;3437.673421025024;3453.827308634558;3454.481827725836;3460.9826950865336;4108.732932359417;4855.708657480563;5108.5185296264035;5113.284140220372;5137.614678899097;4524.185646583614;4533.2600604501085;4549.6360291176625;4551.795169217393;4571;5479.6164268501225;5485.807996720136;5574.554035677136;5590.357108932484;5591.860203494904;3294.225856923621;3556.5198698175673;3763.8870833875026;3840.7695538267794;3841.308564458396;5032.854465958776;5778.739956701958;5792.507636850873;5817.243758311435;5840.386759390245;3851.480050193188;3853.6339047790416;3854.672352849983;3856.0745421098736;3874.050857539921;3795.449659799314;3957.2876882160913;3962.821673024721;3973.2319117992215;3987.3819557968563;3806.4290356446754;4501.414816073955;4574.8562859285175;4575.450945886515;4610.884727881829;5594.468525490072;5599.900037485942;5612.5229355504425;5623.297087864017;5637.408072152447;1162.9069674426025;1175.2713317743055;1261.8170365297165;1262.7600755856358;1291.9289439080753;756.1682149635357;784.8626490364163;795.2882170457408;818.4925346285341;842.5239739547259;4076.9796151019054;4115.8765237042935;4377.993061595851;4455.443069616298;4511.368408422823;4048.5141782985643;4264.722793018444;4598.861529388851;4867.34290870735;4948;4949.430815456197;5297.205419187153;5314.8041690620075;5317.335333083364;5372.489613486712;2977.7320041195962;2999.3851260491547;3003.0990702789077;3013.8493075346146;3017.8641961111803;5198.532132108053;5517.531009864127;5685.374608793029;5805.390434004453;5893.5579831512805;5303.893922121536;5591.692456914909;5836.789765628972;5847.6783776891825;5880.705964701748;4854.514548545118;5853.1220316952795;5887.852803680028;5904.380040095814;5910.320313164041;4949.455559888337;5434.402215756185;5820.563457740602;5832.883342333214;5913.29040515141;4776.20892165438;4822.276658501253;5741.74162162712;5757.6545407274025;5776.826695199151;5799.565032622654;6040.546958978006;6049.879002420015;6066.635007123538;6080;3868.806559672061;3899.6546191563866;3903.0047337928645;3917.6474117329576;3924.117073658404;5123.692578445305;5163.7795747828795;5252.896891652643;5350.063738845764;5847.912281315698;4967.826126085714;5083.644144909821;5446;5614.119270044581;5742.511886489695;4732.485604606492;5209.947900520946;5437.809676661298;5661.745221464962;5704.771809127588;4326.706845371958;4474.731516109044;5428.70142142186;5552.583556233218;5607.654068097258;5450.291462109901;5512.051052686954;5643.435656434488;5666.546676265806;5695.943040569707;5426.929802648014;5500.697461639488;5507.917381239365;5528.917066243929;5551.750171242223 07:55:28 INFO - PROCESS | 1665 | |5;yui.html;692.3353580562659;702.101310322787;707.3527722134247;737.6791095873295;816.4488969945289;14923.47767828125;16090.919545402257;16121.677566448663;16132.677346453078;16164.030158190517;14350.067245629027;14532.854671453282;14549.199794011325;14555.272236388191;14581.854181458182;669.5212922760226;684.7021545627667;686.4714170089028;823.9382046346533;833.150186809454;810.5055915891302;821.5645707774889;824.46821799939;824.785555755502;827.0695467598952;892.5671049540967;893.964241430342;894.7181637784078;894.7449976756626;895.9059298773633;878.0253918150815;878.2973621103124;878.6836738774036;881.1276835932445;881.6429346114834;516.8837011672343;533.6584585865049;645.8127143128487;663.4327649859349;665.0556210181554;14867.107973521515;14912.478063267734;14932.62668433287;14932.701345973128;14962.251887405586;13522.32388380587;13693.931530342285;13696.178229306273;13747;13974.790378144337;10751.978562036673;12506.81239781404;12518.624441266777;12692.238465691995;13216;4249.298865687158;4514.413126293593;4545.886352841172;4706.058788242365;4710.152172608929;112775;113058;113204;115989;117949.41025294819;7992.320652744582;10696.839547406795;10799.190060745475;10827.242093053568;10913.56345746177;19959.700604490943;20287.898560507103;20288.594228115355;20307.492312692302;20312.18751249963;7486.438517111238;7575.431842611826;7780.961095194488;7790.883136752953;8048.154943730824;4333.696641235147;4350.6736994725525;4387.6270517006415;4405.185040767468;4526.728396296233;3492.336456073338;3593.7125029997537;3596.9100772480374;3600.2799440111557;3611.4582812578324;669.1535207961932;671.090672139254;673.461141292145;695.5409429776424;698.8078278473358;511.3378175263043;535.5474623942762;573.7991702903951;574.6584553696778;596.7463827873137;8586.184312490428;9747.171490423252;10232.857709076377;10404.739881502872;10409.115225205791;670.3497607320891;676.9661516924233;681.6046692918096;687.608063403865;688.4767576641789;4467.597916187558;4722.315264286728;4802.591779698765;4845.370101886732;4886.462489126193;102236.48881755544;139390.2121957555;163089;167270;172084;110790;116325;116768.8323116758;143062;152814;73841.6307918457;113036;113332.99999999836;115705;116854.41572792082;9358.485283309483;10003.899961000297;10087.193024557871;10117.443540605338;10120.139788117798;48598;51215.743921280155;64446.67776661087;65556.67221664052;66458;95540.52229738807;97515;99499;100317;100847.49576252072;12306.261624302571;12676.492940282285;12761.553345632858;13045.543405980745;13462.932685336902;10629.681109566725;13693.931530342285;14840.554783356516;15050.924745376204;15520.068795872285;12821.551245706356;13969.930150349182;14070.437182512585;14196.645083872985;14281.71436571242;13057.738845223232;13842.562869840907;13905.513307034205;14079.718405631626;14198.574042778733;11364.431778411212;12548.435320410787;13680.863191367958;13915.860841391457;14312.212828294543;11392.25950313227;11421.31472111676;11483.85161483845;11708.88291117078;12041.698957526132;8922.821543569222;11496.31022138641;11711.941440292743;11738.413079345828;11744.354060526754 07:55:28 INFO - PROCESS | 1665 | __end_tp_report 07:55:28 INFO - PROCESS | 1665 | __start_cc_report 07:55:28 INFO - PROCESS | 1665 | _x_x_mozilla_cycle_collect,1695 07:55:28 INFO - PROCESS | 1665 | __end_cc_report 07:55:28 INFO - PROCESS | 1665 | __startTimestamp1475247328844__endTimestamp 07:55:28 INFO - PROCESS | 1665 | 07:55:28 INFO - PROCESS | 1665 | ------- Summary: start ------- 07:55:28 INFO - PROCESS | 1665 | Number of tests: 6 07:55:28 INFO - PROCESS | 1665 | 07:55:28 INFO - PROCESS | 1665 | [#0] dojo.html Cycles:165 Average:5741.57 Median:5944.73 stddev:635.80 (10.7%) stddev-sans-first:608.95 07:55:28 INFO - PROCESS | 1665 | Values: 3330.2 3352.8 3367.9 3384.1 3412.0 5691.2 5741.2 5743.9 5755.4 5760.1 5681.9 5769.0 5772.1 5782.8 5788.8 5195.2 5254.8 5261.3 5263.1 5300.4 5178.5 5189.5 5319.3 5336.3 5340.5 5238.8 5280.6 5288.0 5297.1 5298.8 5275.9 5277.8 5285.9 5290.4 5293.4 4252.9 5106.5 5186.8 5188.9 5231.7 5749.6 5750.4 5799.8 5803.0 5807.8 6231.9 6268.9 6274.5 6282.4 6299.7 6147.0 6148.3 6192.0 6216.3 6256.5 5757.9 5813.4 5832.7 5846.9 5855.5 6276.8 6281.8 6286.2 6287.9 6300.9 5002.3 6043.4 6111.0 6131.2 6214.4 5006.0 6245.0 6254.9 6269.2 6274.1 6188.3 6233.7 6242.9 6257.4 6260.7 6063.5 6105.3 6108.6 6113.8 6126.9 4916.7 4932.4 4948.8 4952.1 4978.8 4447.3 4451.4 4470.2 4489.0 4516.4 5887.9 5920.0 5944.7 5945.8 5958.9 6125.1 6137.1 6155.9 6196.6 6271.2 5847.7 5905.7 5923.8 5926.2 5950.5 5460.0 5460.7 5461.5 5471.9 5475.7 6169.0 6250.1 6311.7 6315.6 6383.2 6120.5 6187.5 6200.8 6202.5 6203.4 6336.0 6367.0 6371.9 6377.3 6391.8 6065.3 6116.3 6150.4 6157.1 6171.5 6109.7 6135.9 6148.2 6204.9 6206.5 6082.4 6160.9 6170.7 6182.1 6183.4 6025.0 6144.9 6151.4 6152.6 6155.8 5661.6 5855.5 6073.6 6074.3 6100.3 5143.7 5815.5 5971.5 5976.0 6068.3 5806.5 5846.2 5856.2 5859.6 5870.9 07:55:28 INFO - PROCESS | 1665 | 07:55:28 INFO - PROCESS | 1665 | [#1] ext.html Cycles:180 Average:71645.64 Median:38767.42 stddev:158228.26 (408.1%) stddev-sans-first:158582.01 07:55:28 INFO - PROCESS | 1665 | Values: 517.9 524.7 533.5 534.9 555.0 28116.9 31057.9 32201.7 32258.8 39812.2 40267.8 42668.0 42707.4 42729.0 42736.4 9743.5 9859.5 9879.1 9914.6 9924.2 8840.6 9024.8 9776.1 9925.0 11967.8 12022.0 12272.6 12277.9 12317.1 12323.6 10160.3 12258.2 12264.9 12271.5 12272.8 8810.5 8973.7 8995.4 9146.1 12118.3 39388.4 39487.8 39679.0 42029.4 42040.4 3140.9 3449.3 3451.4 3504.1 3812.2 28359.0 29682.0 29687.8 30168.4 30953.4 3291.2 3313.0 3317.9 3424.2 3434.8 499966.0 503519.0 503601.0 503606.0 504480.0 58862.8 59176.0 59178.1 59224.7 59268.1 62428.0 62448.7 62509.7 62587.7 62605.4 16132.7 16623.2 16629.0 16638.8 16638.9 12935.7 12972.9 12994.0 13008.3 13009.3 14118.9 14355.0 14403.0 15858.8 16253.1 6086.6 6730.4 6923.8 6991.5 7005.4 869.7 952.7 959.6 1030.4 1064.9 28779.4 29583.0 29602.6 30090.0 30469.0 1055.1 1146.3 1184.9 1202.7 1262.3 14948.9 15451.8 15658.8 15754.4 15764.5 685592.0 692357.0 692515.0 692983.0 693697.0 57320.1 57454.4 57512.7 57585.7 57641.0 1381.2 1400.5 1416.4 1417.4 1420.1 28871.3 29214.7 29574.7 29683.9 30270.1 49182.8 49381.8 49395.8 49398.8 49453.5 562526.0 564036.0 564517.0 564965.0 565574.0 40153.0 40247.6 40595.4 41334.2 41386.2 38385.6 38632.2 41221.6 44717.3 46576.5 34647.0 38533.0 39121.8 39500.6 40937.4 30849.8 39050.4 39077.4 39690.6 40607.8 37637.6 38164.8 38573.0 38902.6 38978.0 34069.7 34368.2 34632.5 34854.8 34974.8 21348.6 21969.8 25645.5 25959.9 26353.3 07:55:28 INFO - PROCESS | 1665 | 07:55:28 INFO - PROCESS | 1665 | [#2] jquery.html Cycles:180 Average:36296.74 Median:361.20 stddev:107021.79 (29629.4%) stddev-sans-first:107287.98 07:55:28 INFO - PROCESS | 1665 | Values: 352.3 353.5 368.9 381.6 401.4 14875.7 15043.6 15850.7 20887.6 20908.0 19047.3 19710.7 20157.4 20324.2 20735.8 5685.7 5734.3 5940.7 5951.3 5954.1 4431.6 5820.6 5889.9 5897.1 5902.7 5535.5 5830.3 5834.5 5840.3 5858.2 5723.4 5861.7 5875.7 5877.4 5880.2 5505.7 5661.6 5694.0 5698.7 5741.7 12785.2 13007.1 13019.3 13021.2 23821.0 2175.4 2381.3 2420.5 2724.0 2783.8 9215.7 9992.0 10183.2 11606.0 15411.2 1765.8 1828.8 1879.2 1895.4 1908.1 104897.0 121488.0 129101.0 136457.0 138682.3 8761.4 11062.2 11577.6 11596.0 11782.5 14533.4 14557.9 14564.4 14577.4 14585.9 8275.3 8495.5 8538.2 8613.9 8683.7 8351.9 8481.4 8511.3 8661.4 8677.8 3692.5 3777.9 4369.6 4374.1 4451.2 1841.6 1877.6 1880.8 1882.0 1892.7 738.5 847.3 861.5 960.2 997.9 20123.7 20271.7 21365.3 21417.0 21463.2 904.8 942.3 945.7 953.1 1008.4 10546.1 10733.7 11836.3 12179.9 12268.8 626996.5 632451.0 636047.0 648614.0 649608.0 139032.7 139444.0 143220.0 148047.0 150740.0 431.3 455.0 457.5 849.6 876.9 10768.8 10816.4 10944.6 10956.8 11435.8 51834.5 52947.7 55530.6 55847.2 56022.7 76383.0 77991.0 80452.2 80759.6 83299.9 8109.1 8132.7 8301.5 8412.5 8465.5 8867.8 12884.2 12981.7 13215.6 13562.5 10979.8 11022.8 11066.2 11170.4 11401.9 9442.6 10734.9 10774.8 11431.3 11444.5 10911.8 11196.3 11420.8 11446.7 11638.0 8009.5 8012.8 8056.6 8261.0 8377.9 7975.5 8375.4 10476.3 10829.2 10991.7 07:55:28 INFO - PROCESS | 1665 | 07:55:28 INFO - PROCESS | 1665 | [#3] mootools.html Cycles:180 Average:5760.01 Median:5090.02 stddev:3252.93 (63.9%) stddev-sans-first:3245.23 07:55:28 INFO - PROCESS | 1665 | Values: 1358.2 1515.6 1534.7 1748.8 1918.7 7150.9 7990.6 8539.7 9036.8 9038.3 8923.0 9010.7 9016.2 9017.1 9018.2 2389.8 2426.3 2427.6 2427.8 2436.6 2376.7 2413.3 2424.0 2424.2 2426.1 2388.2 2396.4 2407.7 2414.7 2425.5 2365.0 2383.9 2392.3 2397.1 2406.5 2246.7 2272.2 2276.8 2280.8 2282.1 8841.0 8994.1 9010.4 9020.5 9030.2 5271.9 5472.0 5481.8 5484.2 5504.0 3570.8 3607.6 3638.6 3677.1 3686.5 1096.6 1099.5 1102.1 1115.8 1125.3 12020.4 12025.0 12112.2 12144.9 12156.7 3690.6 4040.0 4455.5 4734.3 4761.1 9428.3 9429.5 9435.8 9437.1 9461.1 5239.6 5334.7 5362.5 5363.6 5365.9 4240.9 4500.1 4643.3 4648.2 5039.6 3872.7 3938.6 3996.1 4002.2 4019.1 1184.7 1192.4 1194.4 1205.5 1207.3 713.5 811.2 848.6 942.7 953.3 5759.8 5856.2 5882.8 6020.3 6261.8 942.9 943.8 948.7 962.4 976.5 3838.4 3918.4 3976.4 4010.4 4024.5 8871.0 9257.3 11122.9 11299.7 11333.5 9170.5 11074.4 11261.8 11263.5 11287.3 7867.3 8234.2 8262.1 8350.4 8353.6 5972.2 6019.1 6028.5 6116.9 6194.0 10038.8 10301.4 10467.0 10486.9 10490.4 10256.1 10424.0 10609.5 10699.7 10706.4 7586.2 7662.2 7731.4 7732.7 7734.9 8130.8 8215.4 8314.3 8327.1 8332.9 7362.0 7522.7 7609.1 7628.3 7670.4 7465.2 7505.0 7509.3 7565.6 7571.9 6946.4 7074.1 7162.4 7260.5 7263.5 5100.9 5101.3 5128.1 5132.1 5153.5 4747.1 4901.3 4955.7 5079.1 5165.4 07:55:28 INFO - PROCESS | 1665 | 07:55:28 INFO - PROCESS | 1665 | [#4] prototype.html Cycles:180 Average:4453.13 Median:4907.67 stddev:1389.54 (28.3%) stddev-sans-first:1357.78 07:55:28 INFO - PROCESS | 1665 | Values: 286.2 290.3 291.8 302.7 308.3 4180.7 4571.5 5118.8 5328.5 5390.5 4001.4 4776.2 5181.1 5257.4 5261.7 3384.0 4049.7 4065.8 4119.7 4135.5 3172.6 3766.9 4073.5 4116.2 4123.9 3580.8 3946.7 3966.5 3997.2 4024.6 3534.1 3632.5 3716.5 3729.5 3978.5 3416.2 3437.7 3453.8 3454.5 3461.0 4108.7 4855.7 5108.5 5113.3 5137.6 4524.2 4533.3 4549.6 4551.8 4571.0 5479.6 5485.8 5574.6 5590.4 5591.9 3294.2 3556.5 3763.9 3840.8 3841.3 5032.9 5778.7 5792.5 5817.2 5840.4 3851.5 3853.6 3854.7 3856.1 3874.1 3795.4 3957.3 3962.8 3973.2 3987.4 3806.4 4501.4 4574.9 4575.5 4610.9 5594.5 5599.9 5612.5 5623.3 5637.4 1162.9 1175.3 1261.8 1262.8 1291.9 756.2 784.9 795.3 818.5 842.5 4077.0 4115.9 4378.0 4455.4 4511.4 4048.5 4264.7 4598.9 4867.3 4948.0 4949.4 5297.2 5314.8 5317.3 5372.5 2977.7 2999.4 3003.1 3013.8 3017.9 5198.5 5517.5 5685.4 5805.4 5893.6 5303.9 5591.7 5836.8 5847.7 5880.7 4854.5 5853.1 5887.9 5904.4 5910.3 4949.5 5434.4 5820.6 5832.9 5913.3 4776.2 4822.3 5741.7 5757.7 5776.8 5799.6 6040.5 6049.9 6066.6 6080.0 3868.8 3899.7 3903.0 3917.6 3924.1 5123.7 5163.8 5252.9 5350.1 5847.9 4967.8 5083.6 5446.0 5614.1 5742.5 4732.5 5209.9 5437.8 5661.7 5704.8 4326.7 4474.7 5428.7 5552.6 5607.7 5450.3 5512.1 5643.4 5666.5 5695.9 5426.9 5500.7 5507.9 5528.9 5551.8 07:55:28 INFO - PROCESS | 1665 | 07:55:28 INFO - PROCESS | 1665 | [#5] yui.html Cycles:180 Average:24987.99 Median:96021.85 stddev:40296.72 (42.0%) stddev-sans-first:40368.47 07:55:28 INFO - PROCESS | 1665 | Values: 692.3 702.1 707.4 737.7 816.4 14923.5 16090.9 16121.7 16132.7 16164.0 14350.1 14532.9 14549.2 14555.3 14581.9 669.5 684.7 686.5 823.9 833.2 810.5 821.6 824.5 824.8 827.1 892.6 894.0 894.7 894.7 895.9 878.0 878.3 878.7 881.1 881.6 516.9 533.7 645.8 663.4 665.1 14867.1 14912.5 14932.6 14932.7 14962.3 13522.3 13693.9 13696.2 13747.0 13974.8 10752.0 12506.8 12518.6 12692.2 13216.0 4249.3 4514.4 4545.9 4706.1 4710.2 112775.0 113058.0 113204.0 115989.0 117949.4 7992.3 10696.8 10799.2 10827.2 10913.6 19959.7 20287.9 20288.6 20307.5 20312.2 7486.4 7575.4 7781.0 7790.9 8048.2 4333.7 4350.7 4387.6 4405.2 4526.7 3492.3 3593.7 3596.9 3600.3 3611.5 669.2 671.1 673.5 695.5 698.8 511.3 535.5 573.8 574.7 596.7 8586.2 9747.2 10232.9 10404.7 10409.1 670.3 677.0 681.6 687.6 688.5 4467.6 4722.3 4802.6 4845.4 4886.5 102236.5 139390.2 163089.0 167270.0 172084.0 110790.0 116325.0 116768.8 143062.0 152814.0 73841.6 113036.0 113333.0 115705.0 116854.4 9358.5 10003.9 10087.2 10117.4 10120.1 48598.0 51215.7 64446.7 65556.7 66458.0 95540.5 97515.0 99499.0 100317.0 100847.5 12306.3 12676.5 12761.6 13045.5 13462.9 10629.7 13693.9 14840.6 15050.9 15520.1 12821.6 13969.9 14070.4 14196.6 14281.7 13057.7 13842.6 13905.5 14079.7 14198.6 11364.4 12548.4 13680.9 13915.9 14312.2 11392.3 11421.3 11483.9 11708.9 12041.7 8922.8 11496.3 11711.9 11738.4 11744.4 07:55:28 INFO - PROCESS | 1665 | -------- Summary: end -------- 07:55:28 INFO - PROCESS | 1665 | 07:55:29 INFO - TEST-INFO | 1665: exit 0 07:55:29 INFO - TEST-OK | dromaeo_css | took 1118040ms 07:55:29 INFO - TEST-START | kraken 07:55:29 INFO - operating with platform_type : mac_ 07:55:29 INFO - Initialising browser for kraken test... 07:55:29 INFO - TEST-INFO | started process 1670 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/tmp5g4mNg/profile http://localhost:49278/getInfo.html) 07:55:31 INFO - PROCESS | 1670 | __metrics Screen width/height:1600/1200 07:55:31 INFO - PROCESS | 1670 | colorDepth:24 07:55:31 INFO - PROCESS | 1670 | Browser inner width/height: 1024/689 07:55:31 INFO - PROCESS | 1670 | __metrics 07:55:31 INFO - PROCESS | 1670 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:55:31 INFO - PROCESS | 1670 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:55:32 INFO - TEST-INFO | 1670: exit 0 07:55:32 INFO - Browser initialized. 07:55:32 INFO - Running cycle 1/1 for kraken test... 07:55:32 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/tmp5g4mNg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:55:44 INFO - PROCESS | 1671 | RSS: Main: 218812416 07:55:44 INFO - PROCESS | 1671 | 07:55:47 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection) 07:55:48 INFO - PROCESS | 1671 | RSS: Main: 269479936 07:55:48 INFO - PROCESS | 1671 | 07:55:51 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-dft) 07:55:51 INFO - PROCESS | 1671 | RSS: Main: 280596480 07:55:51 INFO - PROCESS | 1671 | 07:55:54 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-fft) 07:55:55 INFO - PROCESS | 1671 | RSS: Main: 377819136 07:55:55 INFO - PROCESS | 1671 | 07:55:57 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator) 07:55:58 INFO - PROCESS | 1671 | RSS: Main: 278540288 07:55:58 INFO - PROCESS | 1671 | 07:56:00 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:56:00 INFO - PROCESS | 1671 | RSS: Main: 279351296 07:56:00 INFO - PROCESS | 1671 | 07:56:03 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom) 07:56:04 INFO - PROCESS | 1671 | RSS: Main: 316878848 07:56:04 INFO - PROCESS | 1671 | 07:56:07 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate) 07:56:07 INFO - PROCESS | 1671 | RSS: Main: 317677568 07:56:07 INFO - PROCESS | 1671 | 07:56:10 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial) 07:56:11 INFO - PROCESS | 1671 | RSS: Main: 316178432 07:56:11 INFO - PROCESS | 1671 | 07:56:12 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:56:13 INFO - PROCESS | 1671 | RSS: Main: 289300480 07:56:13 INFO - PROCESS | 1671 | 07:56:15 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:56:15 INFO - PROCESS | 1671 | RSS: Main: 295145472 07:56:15 INFO - PROCESS | 1671 | 07:56:17 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:56:18 INFO - PROCESS | 1671 | RSS: Main: 301297664 07:56:18 INFO - PROCESS | 1671 | 07:56:21 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:56:22 INFO - PROCESS | 1671 | RSS: Main: 312684544 07:56:22 INFO - PROCESS | 1671 | 07:56:24 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:56:25 INFO - PROCESS | 1671 | RSS: Main: 308699136 07:56:25 INFO - PROCESS | 1671 | 07:56:27 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49278/tests/kraken/driver.html?testName=ai-astar) 07:56:27 INFO - PROCESS | 1671 | RSS: Main: 351748096 07:56:27 INFO - PROCESS | 1671 | 07:56:27 INFO - PROCESS | 1671 | __start_tp_report 07:56:27 INFO - PROCESS | 1671 | _x_x_mozilla_page_load 07:56:27 INFO - PROCESS | 1671 | _x_x_mozilla_page_load_details 07:56:27 INFO - PROCESS | 1671 | |i|pagename|runs| 07:56:27 INFO - PROCESS | 1671 | |0;ai-astar;114;114;115;114;113;114;114;119;168;149 07:56:27 INFO - PROCESS | 1671 | |1;audio-beat-detection;146;108;109;142;109;108;103;111;147;140 07:56:27 INFO - PROCESS | 1671 | |2;audio-dft;185;186;185;183;180;183;183;185;182;182 07:56:27 INFO - PROCESS | 1671 | |3;audio-fft;82;60;59;109;88;85;79;59;81;57 07:56:27 INFO - PROCESS | 1671 | |4;audio-oscillator;84;70;94;70;69;68;92;69;68;91 07:56:27 INFO - PROCESS | 1671 | |5;imaging-gaussian-blur;86;96;132;111;87;83;87;85;86;87 07:56:27 INFO - PROCESS | 1671 | |6;imaging-darkroom;92;93;92;93;93;94;93;105;134;91 07:56:27 INFO - PROCESS | 1671 | |7;imaging-desaturate;85;86;84;84;94;125;85;86;88;86 07:56:27 INFO - PROCESS | 1671 | |8;json-parse-financial;57;54;54;52;53;57;55;57;58;57 07:56:27 INFO - PROCESS | 1671 | |9;json-stringify-tinderbox;70;70;71;72;73;67;68;67;68;69 07:56:27 INFO - PROCESS | 1671 | |10;stanford-crypto-aes;85;83;83;80;85;82;84;86;90;86 07:56:27 INFO - PROCESS | 1671 | |11;stanford-crypto-ccm;137;147;121;149;132;140;147;154;190;152 07:56:27 INFO - PROCESS | 1671 | |12;stanford-crypto-pbkdf2;164;163;163;161;163;164;163;164;166;161 07:56:27 INFO - PROCESS | 1671 | |13;stanford-crypto-sha256-iterative;66;72;81;88;58;75;83;88;88;86 07:56:27 INFO - PROCESS | 1671 | __end_tp_report 07:56:27 INFO - PROCESS | 1671 | __start_cc_report 07:56:27 INFO - PROCESS | 1671 | _x_x_mozilla_cycle_collect,1996 07:56:27 INFO - PROCESS | 1671 | __end_cc_report 07:56:27 INFO - PROCESS | 1671 | __startTimestamp1475247387751__endTimestamp 07:56:27 INFO - PROCESS | 1671 | 07:56:27 INFO - PROCESS | 1671 | ------- Summary: start ------- 07:56:27 INFO - PROCESS | 1671 | Number of tests: 14 07:56:27 INFO - PROCESS | 1671 | 07:56:27 INFO - PROCESS | 1671 | [#0] ai-astar Cycles:10 Average:123.40 Median:114.50 stddev:19.10 (16.7%) stddev-sans-first:19.96 07:56:27 INFO - PROCESS | 1671 | Values: 114.0 114.0 115.0 114.0 113.0 114.0 114.0 119.0 168.0 149.0 07:56:27 INFO - PROCESS | 1671 | 07:56:27 INFO - PROCESS | 1671 | [#1] audio-beat-detection Cycles:10 Average:122.30 Median:125.50 stddev:18.67 (14.9%) stddev-sans-first:17.72 07:56:27 INFO - PROCESS | 1671 | Values: 146.0 108.0 109.0 142.0 109.0 108.0 103.0 111.0 147.0 140.0 07:56:27 INFO - PROCESS | 1671 | 07:56:27 INFO - PROCESS | 1671 | [#2] audio-dft Cycles:10 Average:183.40 Median:184.00 stddev:1.84 (1.0%) stddev-sans-first:1.86 07:56:27 INFO - PROCESS | 1671 | Values: 185.0 186.0 185.0 183.0 180.0 183.0 183.0 185.0 182.0 182.0 07:56:27 INFO - PROCESS | 1671 | 07:56:27 INFO - PROCESS | 1671 | [#3] audio-fft Cycles:10 Average:75.90 Median:80.00 stddev:16.93 (21.2%) stddev-sans-first:17.81 07:56:27 INFO - PROCESS | 1671 | Values: 82.0 60.0 59.0 109.0 88.0 85.0 79.0 59.0 81.0 57.0 07:56:27 INFO - PROCESS | 1671 | 07:56:27 INFO - PROCESS | 1671 | [#4] audio-oscillator Cycles:10 Average:77.50 Median:77.00 stddev:11.28 (14.6%) stddev-sans-first:11.71 07:56:27 INFO - PROCESS | 1671 | Values: 84.0 70.0 94.0 70.0 69.0 68.0 92.0 69.0 68.0 91.0 07:56:27 INFO - PROCESS | 1671 | 07:56:27 INFO - PROCESS | 1671 | [#5] imaging-gaussian-blur Cycles:10 Average:94.00 Median:86.50 stddev:15.68 (18.1%) stddev-sans-first:16.37 07:56:27 INFO - PROCESS | 1671 | Values: 86.0 96.0 132.0 111.0 87.0 83.0 87.0 85.0 86.0 87.0 07:56:27 INFO - PROCESS | 1671 | 07:56:27 INFO - PROCESS | 1671 | [#6] imaging-darkroom Cycles:10 Average:98.00 Median:93.00 stddev:13.26 (14.3%) stddev-sans-first:13.88 07:56:27 INFO - PROCESS | 1671 | Values: 92.0 93.0 92.0 93.0 93.0 94.0 93.0 105.0 134.0 91.0 07:56:27 INFO - PROCESS | 1671 | 07:56:27 INFO - PROCESS | 1671 | [#7] imaging-desaturate Cycles:10 Average:90.30 Median:86.00 stddev:12.53 (14.6%) stddev-sans-first:13.15 07:56:27 INFO - PROCESS | 1671 | Values: 85.0 86.0 84.0 84.0 94.0 125.0 85.0 86.0 88.0 86.0 07:56:27 INFO - PROCESS | 1671 | 07:56:27 INFO - PROCESS | 1671 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:57.00 stddev:2.07 (3.6%) stddev-sans-first:2.11 07:56:27 INFO - PROCESS | 1671 | Values: 57.0 54.0 54.0 52.0 53.0 57.0 55.0 57.0 58.0 57.0 07:56:27 INFO - PROCESS | 1671 | 07:56:27 INFO - PROCESS | 1671 | [#9] json-stringify-tinderbox Cycles:10 Average:69.50 Median:70.00 stddev:2.07 (3.0%) stddev-sans-first:2.19 07:56:27 INFO - PROCESS | 1671 | Values: 70.0 70.0 71.0 72.0 73.0 67.0 68.0 67.0 68.0 69.0 07:56:27 INFO - PROCESS | 1671 | 07:56:27 INFO - PROCESS | 1671 | [#10] stanford-crypto-aes Cycles:10 Average:84.40 Median:85.00 stddev:2.72 (3.2%) stddev-sans-first:2.87 07:56:27 INFO - PROCESS | 1671 | Values: 85.0 83.0 83.0 80.0 85.0 82.0 84.0 86.0 90.0 86.0 07:56:27 INFO - PROCESS | 1671 | 07:56:27 INFO - PROCESS | 1671 | [#11] stanford-crypto-ccm Cycles:10 Average:146.90 Median:148.00 stddev:18.19 (12.3%) stddev-sans-first:18.93 07:56:27 INFO - PROCESS | 1671 | Values: 137.0 147.0 121.0 149.0 132.0 140.0 147.0 154.0 190.0 152.0 07:56:27 INFO - PROCESS | 1671 | 07:56:27 INFO - PROCESS | 1671 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.20 Median:163.50 stddev:1.48 (0.9%) stddev-sans-first:1.54 07:56:27 INFO - PROCESS | 1671 | Values: 164.0 163.0 163.0 161.0 163.0 164.0 163.0 164.0 166.0 161.0 07:56:27 INFO - PROCESS | 1671 | 07:56:27 INFO - PROCESS | 1671 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:78.50 Median:84.50 stddev:10.46 (12.4%) stddev-sans-first:10.07 07:56:27 INFO - PROCESS | 1671 | Values: 66.0 72.0 81.0 88.0 58.0 75.0 83.0 88.0 88.0 86.0 07:56:27 INFO - PROCESS | 1671 | -------- Summary: end -------- 07:56:27 INFO - PROCESS | 1671 | 07:56:28 INFO - TEST-INFO | 1671: exit 0 07:56:28 INFO - TEST-OK | kraken | took 59270ms 07:56:28 INFO - SUITE-END | took 1177s 07:56:28 INFO - Completed test suite (00:19:37) 07:56:28 INFO - javascript benchmark 07:56:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3330.2007518195633, 3352.7653064285496, 3367.898963031107, 3384.103212648647, 3412.0, 5691.174779656947, 5741.224934633823, 5743.9138412923785, 5755.4244575542425, 5760.107183386572, 5681.943180568193, 5769.0, 5772.134179873021, 5782.768689252435, 5788.82633520994, 5195.168772996321, 5254.789808407659, 5261.289725886994, 5263.0526505229045, 5300.416954135042, 5178.456262092483, 5189.481051894818, 5319.255304257388, 5336.332958380202, 5340.519353258206, 5238.816641417551, 5280.577553795687, 5288.021715982555, 5297.073012222865, 5298.814541491049, 5275.865688876891, 5277.841664750044, 5285.894282114375, 5290.418054014055, 5293.364796224478, 4252.9149417011795, 5106.463821298785, 5186.844394668166, 5188.870278243074, 5231.738413079369, 5749.626274292199, 5750.424957504216, 5799.768009279624, 5803.042497987827, 5807.796727114573, 6231.87536249277, 6268.905966410507, 6274.466670333027, 6282.434580887742, 6299.748010079591, 6146.969265153691, 6148.292946311142, 6191.9690401547705, 6216.254049514042, 6256.5307601930035, 5757.913631295534, 5813.389594092601, 5832.679202643895, 5846.853828654318, 5855.473007429352, 6276.811695649138, 6281.811545653638, 6286.15136956505, 6287.874242515124, 6300.873982520324, 5002.324686167393, 6043.365446628129, 6111.022236442237, 6131.233595800525, 6214.4407003369915, 5005.974970125126, 6244.968775156095, 6254.874902501924, 6269.153664255267, 6274.121622972787, 6188.257409110845, 6233.688315584202, 6242.875142497124, 6257.43683068526, 6260.686965651699, 6063.514918806573, 6105.308121371101, 6108.63890615289, 6113.755449781959, 6126.914660831478, 4916.729579873141, 4932.4081110267, 4948.752562371939, 4952.059108769322, 4978.751062446936, 4447.310666846644, 4451.376807246988, 4470.173017991682, 4488.977555112268, 4516.435445569304, 5887.882242355129, 5919.970400147971, 5944.7324870380935, 5945.821625351246, 5958.897603943197, 6125.084128922883, 6137.070562331885, 6155.907661385083, 6196.628202307876, 6271.153394291803, 5847.678377689268, 5905.734241959122, 5923.7926672566255, 5926.170336152942, 5950.523958083343, 5460.044492213847, 5460.672359658433, 5461.453854614507, 5471.945280547144, 5475.698836563947, 6168.969155154375, 6250.124982502362, 6311.684415779101, 6315.5894866833505, 6383.234011918599, 6120.508083830795, 6187.474064704551, 6200.81397558074, 6202.503799696104, 6203.379662033941, 6335.968320158369, 6367.0, 6371.872562548816, 6377.266614339411, 6391.776287829904, 6065.302490213506, 6116.29662588808, 6150.384961503813, 6157.1072194532435, 6171.506279497539, 6109.725062372293, 6135.93706321624, 6148.1699970503405, 6204.906926396017, 6206.472449841814, 6082.3613520581475, 6160.876782464416, 6170.660613666291, 6182.1345011697495, 6183.4125758054715, 6024.969875150597, 6144.938550614436, 6151.415615516519, 6152.569320147547, 6155.815325540241, 5661.553809701958, 5855.502282306052, 6073.605215660968, 6074.3318234994995, 6100.298465676504, 5143.665661731976, 5815.476607105381, 5971.492423144082, 5975.954208013667, 6068.271807383142, 5806.506446952057, 5846.181534585076, 5856.180134781049, 5859.648421094748, 5870.911936320873], "value": 5701.976442286716, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [517.9171332586785, 524.6537285391643, 533.519832151064, 534.8903474787667, 554.9999999999999, 28116.85941570292, 31057.91297304592, 32201.67798322016, 32258.838705806436, 39812.20375592494, 40267.798661006724, 42668.0, 42707.359389609184, 42729.0, 42736.35895461563, 9743.464109473995, 9859.457729824857, 9879.061489158554, 9914.603415863357, 9924.15644670204, 8840.602172902234, 9024.819503609924, 9776.120149186607, 9925.0, 11967.760644787142, 12022.0, 12272.570460033901, 12277.894989450948, 12317.076219283545, 12323.568675096374, 10160.339577927449, 12258.20321679088, 12264.877351226463, 12271.509139634403, 12272.754544909096, 8810.515421651806, 8973.730788076367, 8995.415298005608, 9146.131117543822, 12118.333491657955, 39388.40917386241, 39487.80256098701, 39679.008024799325, 42029.36955945663, 42040.36939445911, 3140.905772826819, 3449.344624521333, 3451.36149812283, 3504.0714210734177, 3812.1994381179984, 28359.007434739684, 29681.961131360516, 29687.81248750069, 30168.396632067455, 30953.380932381453, 3291.210109573709, 3312.9834350828332, 3317.9004629861142, 3424.2124311408515, 3434.7767395119236, 499965.9999999964, 503519.0, 503601.0, 503606.0, 504480.0, 58862.822743544886, 59176.0, 59178.11232831511, 59224.7038764812, 59268.11097833536, 62428.0, 62448.687756561834, 62509.68745156245, 62587.6870615644, 62605.373946259955, 16132.67734645324, 16623.168841558116, 16629.002259864446, 16638.75041874373, 16638.91847029939, 12935.741285174245, 12972.870271297355, 12994.025448091432, 13008.349582520836, 13009.284489353176, 14118.929405353112, 14355.0, 14403.0, 15858.762118568231, 16253.10607916576, 6086.630508135722, 6730.360615741497, 6923.826904327432, 6991.475639327071, 7005.404540614003, 869.7347309070668, 952.7237101240701, 959.6113574002541, 1030.4126647810676, 1064.9414282214552, 28779.424411511653, 29583.0, 29602.555961660593, 30090.0, 30469.0, 1055.0616532955682, 1146.3179408252076, 1184.9407529623657, 1202.7053371923935, 1262.3246563088703, 14948.850511494746, 15451.84548154504, 15658.843411565738, 15754.448594299145, 15764.52857128694, 685592.0, 692357.0, 692515.0, 692983.0, 693697.0, 57320.14019789707, 57454.42545574491, 57512.712436438385, 57585.712071439375, 57641.0, 1381.2058066611537, 1400.4678222275675, 1416.3980308368903, 1417.397606017459, 1420.1195258939317, 28871.278218044718, 29214.70785292205, 29574.704252958054, 29683.851580741957, 30270.091897243117, 49182.77043073952, 49381.75309123431, 49395.75302123466, 49398.753006234736, 49453.50546494633, 562526.0, 564036.0, 564517.0, 564965.0, 565574.0, 40152.99235038178, 40247.597524024386, 40595.39106913458, 41334.1733165329, 41386.172276554906, 38385.616143838204, 38632.227355452174, 41221.58778412177, 44717.329240060775, 46576.53423465722, 34647.0, 38533.0, 39121.82634520969, 39500.604993949695, 40937.385939211534, 30849.845750771103, 39050.41424378694, 39077.41383879187, 39690.60309396985, 40607.796961015, 37637.623623763415, 38164.809175953946, 38573.0, 38902.610973889896, 38978.0, 34069.659303406646, 34368.17402518199, 34632.480512792834, 34854.82572587222, 34974.82512587421, 21348.573028539653, 21969.780302196774, 25645.487090258463, 25959.870200648875, 26353.341166470225], "value": 20269.28170565949, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.279588242045, 353.5174486825483, 368.88564544991056, 381.57454438301295, 401.3658419696877, 14875.702485950287, 15043.623909402271, 15850.716546705562, 20887.582248355026, 20908.0, 19047.333343332986, 19710.70433943492, 20157.39527814164, 20324.187032518683, 20735.792642073575, 5685.687287199213, 5734.299829354077, 5940.673262970535, 5951.256092988377, 5954.106883967418, 4431.578999994996, 5820.621659592134, 5889.85275368115, 5897.115432685088, 5902.675352855591, 5535.501804837564, 5830.300363956331, 5834.5040671542965, 5840.299164100314, 5858.209141765849, 5723.399043100477, 5861.736221870026, 5875.735591898332, 5877.382874798127, 5880.2355693759755, 5505.697186654733, 5661.631993920382, 5694.0, 5698.658080515141, 5741.741621627037, 12785.232886026775, 13007.089503734742, 13019.349032548334, 13021.218726876417, 23821.0, 2175.423512769117, 2381.297517232403, 2420.455397535558, 2724.0465836957105, 2783.7633801126726, 9215.677451289239, 9991.950040249752, 10183.236257280734, 11606.0, 15411.22943852803, 1765.7704498415253, 1828.7531183290218, 1879.1543805287674, 1895.3650527073446, 1908.1318000309825, 104896.95103049025, 121488.0, 129101.0, 136457.0, 138682.3065884674, 8761.386702930733, 11062.170337224741, 11577.594784182513, 11596.01433878113, 11782.52869885195, 14533.418663253562, 14557.908156888276, 14564.41742330295, 14577.41690332396, 14585.92707036458, 8275.337972962148, 8495.490270583785, 8538.231559159705, 8613.870791938127, 8683.652653893774, 8351.874721879176, 8481.363897707573, 8511.319094472427, 8661.393702440895, 8677.78716427307, 3692.538432695913, 3777.905552361213, 4369.584889435499, 4374.059577190919, 4451.176532341462, 1841.5948491332153, 1877.568159323336, 1880.7837098733821, 1881.9529511762316, 1892.687706528435, 738.5421038955882, 847.2713466418875, 861.5476874640864, 960.159860122393, 997.8702768640176, 20123.698144527843, 20271.695924561143, 21365.25221617236, 21417.0, 21463.248786292406, 904.7828521155008, 942.2509105261333, 945.7399215215871, 953.1183655118987, 1008.4050410257836, 10546.050855422895, 10733.677989660166, 11836.349000804867, 12179.939100304442, 12268.754624907451, 626996.4804441526, 632451.0, 636047.0, 648614.0, 649608.0, 139032.7482940487, 139444.0, 143220.0, 148047.0, 150740.0, 431.3357429558508, 455.04894769931, 457.46476622352594, 849.6006876767909, 876.8816209811721, 10768.784624307627, 10816.4050977197, 10944.562217511211, 10956.835647465454, 11435.828462573234, 51834.481655182964, 52947.73526132345, 55530.61173470695, 55847.162292566456, 56022.71988640031, 76383.0, 77990.9926571674, 80452.19547804446, 80759.59620202097, 83299.91750206293, 8109.134898973151, 8132.715354962548, 8301.501909885426, 8412.495250285003, 8465.492070475791, 8867.778305542155, 12884.226946383247, 12981.728197565199, 13215.60353189406, 13562.525311614047, 10979.804039192033, 11022.834657480305, 11066.170037247077, 11170.385628790495, 11401.942990284995, 9442.622295108118, 10734.892651073702, 10774.784504310026, 11431.314121152758, 11444.542218311175, 10911.836322455329, 11196.272242304223, 11420.771584568429, 11446.656600302003, 11638.010769084724, 8009.478199142144, 8012.83974320522, 8056.637451314587, 8260.958695206486, 8377.916220837957, 7975.521468711896, 8375.41372103947, 10476.323788193853, 10829.24195306321, 10991.725206869893], "value": 9167.820904816339, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1358.2122369025965, 1515.57563882113, 1534.7467667834803, 1748.8338607832259, 1918.6642337590918, 7150.928490715098, 7990.640421181046, 8539.658413663454, 9036.77408064797, 9038.322125840572, 8923.0, 9010.68462603809, 9016.188543031127, 9017.143371379725, 9018.188363047324, 2389.7729715676983, 2426.259990702835, 2427.6237183236626, 2427.8057755379527, 2436.5735996200683, 2376.702912135983, 2413.2760171948435, 2424.0425032112307, 2424.212131057405, 2426.0538390027905, 2388.152205966883, 2396.436837343223, 2407.6749638798715, 2414.6619473273754, 2425.50277193175, 2365.042157926043, 2383.8808059597036, 2392.306231192952, 2397.0531640002278, 2406.4585468269674, 2246.663235374949, 2272.193371353179, 2276.7723227677266, 2280.8061314788265, 2282.0643536150264, 8840.955795220983, 8994.145556172152, 9010.369274150811, 9020.458772473607, 9030.232430243437, 5271.920921186185, 5472.0, 5481.780728770885, 5484.204790305424, 5503.972480137613, 3570.785752854811, 3607.603163651996, 3638.5815631202486, 3677.117491801975, 3686.5207523022104, 1096.572336788653, 1099.4942326529726, 1102.090775110537, 1115.7880002799443, 1125.291066628019, 12020.398980050963, 12025.037996960222, 12112.21270617416, 12144.939275303566, 12156.696082598006, 3690.55713314404, 4039.9698076990767, 4455.465344158657, 4734.337192793012, 4761.095391875532, 9428.292878034175, 9429.528523573794, 9435.764105897408, 9437.103475169848, 9461.05389461062, 5239.554637855748, 5334.67991920486, 5362.51737343641, 5363.624546281723, 5365.892682146336, 4240.893977650583, 4500.144972455223, 4643.2802915548145, 4648.209804333272, 5039.647224694309, 3872.6708229800784, 3938.6258305460933, 3996.1008773025837, 4002.2195671844293, 4019.135885784512, 1184.6979020349756, 1192.3680449361852, 1194.3908606610692, 1205.4635687119148, 1207.3480320626938, 713.4969846258375, 811.2090711556185, 848.5969164646867, 942.6512190489562, 953.2945620240972, 5759.769609215668, 5856.238688970492, 5882.823435312955, 6020.337762846083, 6261.843453913598, 942.8679984802134, 943.8112377524523, 948.6529128637213, 962.3888830592484, 976.4824642939253, 3838.3666694995013, 3918.3730603103936, 3976.4035394691027, 4010.4184893190322, 4024.5371782245415, 8871.0, 9257.259419246444, 11122.943320384551, 11299.717507062389, 11333.489992950337, 9170.495622740813, 11074.446277686084, 11261.774764504664, 11263.49314280843, 11287.322760634388, 7867.252611001945, 8234.217749313926, 8262.091169971298, 8350.4154709171, 8353.582320883932, 5972.163897054329, 6019.127226552213, 6028.517718582415, 6116.877662446637, 6194.008958566607, 10038.799224015333, 10301.433421161908, 10467.0, 10486.895131048592, 10490.423026733602, 10256.12822910061, 10424.0, 10609.469526523797, 10699.679009629723, 10706.411147386969, 7586.24137586237, 7662.157162712208, 7731.420143489373, 7732.690692372242, 7734.92265077342, 8130.75607731769, 8215.383846211438, 8314.251717345467, 8327.084020757833, 8332.875006875023, 7362.0, 7522.736704215326, 7609.124950630527, 7628.313451789366, 7670.424718146273, 7465.216152304147, 7505.024346835095, 7509.324160825552, 7565.583892885944, 7571.886421703789, 6946.444284457332, 7074.080369551925, 7162.355388015104, 7260.4554658399775, 7263.4915555910575, 5100.928804951001, 5101.336826212569, 5128.102582048201, 5132.10188217053, 5153.510416510426, 4747.098051370229, 4901.289313049517, 4955.677880937727, 5079.11115554769, 5165.380154381498], "value": 4615.05767393147, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [286.1686799846446, 290.32644265304504, 291.84094668405703, 302.7154474793694, 308.2663261437778, 4180.745776267123, 4571.542845715427, 5118.769655365508, 5328.49379308966, 5390.5418039466695, 4001.419084690373, 4776.164171270023, 5181.119209734345, 5257.36911570612, 5261.711430356027, 3384.0, 4049.6962727795385, 4065.79671016448, 4119.732217405859, 4135.524414692311, 3172.6034245719284, 3766.8869933901888, 4073.5111786585503, 4116.242117781094, 4123.938030984507, 3580.8004318553317, 3946.6645335146545, 3966.52401711795, 3997.2005598880196, 4024.5774193709676, 3534.063473179584, 3632.5469812075116, 3716.513394642151, 3729.4778730977687, 3978.5026871641044, 3416.197193659488, 3437.673421025024, 3453.827308634558, 3454.481827725836, 3460.9826950865336, 4108.732932359417, 4855.708657480563, 5108.5185296264035, 5113.284140220372, 5137.614678899097, 4524.185646583614, 4533.2600604501085, 4549.6360291176625, 4551.795169217393, 4571.0, 5479.6164268501225, 5485.807996720136, 5574.554035677136, 5590.357108932484, 5591.860203494904, 3294.225856923621, 3556.5198698175673, 3763.8870833875026, 3840.7695538267794, 3841.308564458396, 5032.854465958776, 5778.739956701958, 5792.507636850873, 5817.243758311435, 5840.386759390245, 3851.480050193188, 3853.6339047790416, 3854.672352849983, 3856.0745421098736, 3874.050857539921, 3795.449659799314, 3957.2876882160913, 3962.821673024721, 3973.2319117992215, 3987.3819557968563, 3806.4290356446754, 4501.414816073955, 4574.8562859285175, 4575.450945886515, 4610.884727881829, 5594.468525490072, 5599.900037485942, 5612.5229355504425, 5623.297087864017, 5637.408072152447, 1162.9069674426025, 1175.2713317743055, 1261.8170365297165, 1262.7600755856358, 1291.9289439080753, 756.1682149635357, 784.8626490364163, 795.2882170457408, 818.4925346285341, 842.5239739547259, 4076.9796151019054, 4115.8765237042935, 4377.993061595851, 4455.443069616298, 4511.368408422823, 4048.5141782985643, 4264.722793018444, 4598.861529388851, 4867.34290870735, 4948.0, 4949.430815456197, 5297.205419187153, 5314.8041690620075, 5317.335333083364, 5372.489613486712, 2977.7320041195962, 2999.3851260491547, 3003.0990702789077, 3013.8493075346146, 3017.8641961111803, 5198.532132108053, 5517.531009864127, 5685.374608793029, 5805.390434004453, 5893.5579831512805, 5303.893922121536, 5591.692456914909, 5836.789765628972, 5847.6783776891825, 5880.705964701748, 4854.514548545118, 5853.1220316952795, 5887.852803680028, 5904.380040095814, 5910.320313164041, 4949.455559888337, 5434.402215756185, 5820.563457740602, 5832.883342333214, 5913.29040515141, 4776.20892165438, 4822.276658501253, 5741.74162162712, 5757.6545407274025, 5776.826695199151, 5799.565032622654, 6040.546958978006, 6049.879002420015, 6066.635007123538, 6080.0, 3868.806559672061, 3899.6546191563866, 3903.0047337928645, 3917.6474117329576, 3924.117073658404, 5123.692578445305, 5163.7795747828795, 5252.896891652643, 5350.063738845764, 5847.912281315698, 4967.826126085714, 5083.644144909821, 5446.0, 5614.119270044581, 5742.511886489695, 4732.485604606492, 5209.947900520946, 5437.809676661298, 5661.745221464962, 5704.771809127588, 4326.706845371958, 4474.731516109044, 5428.70142142186, 5552.583556233218, 5607.654068097258, 5450.291462109901, 5512.051052686954, 5643.435656434488, 5666.546676265806, 5695.943040569707, 5426.929802648014, 5500.697461639488, 5507.917381239365, 5528.917066243929, 5551.750171242223], "value": 4002.847964262032, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [692.3353580562659, 702.101310322787, 707.3527722134247, 737.6791095873295, 816.4488969945289, 14923.47767828125, 16090.919545402257, 16121.677566448663, 16132.677346453078, 16164.030158190517, 14350.067245629027, 14532.854671453282, 14549.199794011325, 14555.272236388191, 14581.854181458182, 669.5212922760226, 684.7021545627667, 686.4714170089028, 823.9382046346533, 833.150186809454, 810.5055915891302, 821.5645707774889, 824.46821799939, 824.785555755502, 827.0695467598952, 892.5671049540967, 893.964241430342, 894.7181637784078, 894.7449976756626, 895.9059298773633, 878.0253918150815, 878.2973621103124, 878.6836738774036, 881.1276835932445, 881.6429346114834, 516.8837011672343, 533.6584585865049, 645.8127143128487, 663.4327649859349, 665.0556210181554, 14867.107973521515, 14912.478063267734, 14932.62668433287, 14932.701345973128, 14962.251887405586, 13522.32388380587, 13693.931530342285, 13696.178229306273, 13747.0, 13974.790378144337, 10751.978562036673, 12506.81239781404, 12518.624441266777, 12692.238465691995, 13216.0, 4249.298865687158, 4514.413126293593, 4545.886352841172, 4706.058788242365, 4710.152172608929, 112775.0, 113058.0, 113204.0, 115989.0, 117949.41025294819, 7992.320652744582, 10696.839547406795, 10799.190060745475, 10827.242093053568, 10913.56345746177, 19959.700604490943, 20287.898560507103, 20288.594228115355, 20307.492312692302, 20312.18751249963, 7486.438517111238, 7575.431842611826, 7780.961095194488, 7790.883136752953, 8048.154943730824, 4333.696641235147, 4350.6736994725525, 4387.6270517006415, 4405.185040767468, 4526.728396296233, 3492.336456073338, 3593.7125029997537, 3596.9100772480374, 3600.2799440111557, 3611.4582812578324, 669.1535207961932, 671.090672139254, 673.461141292145, 695.5409429776424, 698.8078278473358, 511.3378175263043, 535.5474623942762, 573.7991702903951, 574.6584553696778, 596.7463827873137, 8586.184312490428, 9747.171490423252, 10232.857709076377, 10404.739881502872, 10409.115225205791, 670.3497607320891, 676.9661516924233, 681.6046692918096, 687.608063403865, 688.4767576641789, 4467.597916187558, 4722.315264286728, 4802.591779698765, 4845.370101886732, 4886.462489126193, 102236.48881755544, 139390.2121957555, 163089.0, 167270.0, 172084.0, 110790.0, 116325.0, 116768.8323116758, 143062.0, 152814.0, 73841.6307918457, 113036.0, 113332.99999999836, 115705.0, 116854.41572792082, 9358.485283309483, 10003.899961000297, 10087.193024557871, 10117.443540605338, 10120.139788117798, 48598.0, 51215.743921280155, 64446.67776661087, 65556.67221664052, 66458.0, 95540.52229738807, 97515.0, 99499.0, 100317.0, 100847.49576252072, 12306.261624302571, 12676.492940282285, 12761.553345632858, 13045.543405980745, 13462.932685336902, 10629.681109566725, 13693.931530342285, 14840.554783356516, 15050.924745376204, 15520.068795872285, 12821.551245706356, 13969.930150349182, 14070.437182512585, 14196.645083872985, 14281.71436571242, 13057.738845223232, 13842.562869840907, 13905.513307034205, 14079.718405631626, 14198.574042778733, 11364.431778411212, 12548.435320410787, 13680.863191367958, 13915.860841391457, 14312.212828294543, 11392.25950313227, 11421.31472111676, 11483.85161483845, 11708.88291117078, 12041.698957526132, 8922.821543569222, 11496.31022138641, 11711.941440292743, 11738.413079345828, 11744.354060526754], "value": 7810.627110919854, "unit": "score"}], "name": "dromaeo_css", "value": 7312.538073971704, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 115.0, 114.0, 113.0, 114.0, 114.0, 119.0, 168.0, 149.0], "value": 123.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 108.0, 109.0, 142.0, 109.0, 108.0, 103.0, 111.0, 147.0, 140.0], "value": 122.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 186.0, 185.0, 183.0, 180.0, 183.0, 183.0, 185.0, 182.0, 182.0], "value": 183.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 60.0, 59.0, 109.0, 88.0, 85.0, 79.0, 59.0, 81.0, 57.0], "value": 75.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 70.0, 94.0, 70.0, 69.0, 68.0, 92.0, 69.0, 68.0, 91.0], "value": 77.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 96.0, 132.0, 111.0, 87.0, 83.0, 87.0, 85.0, 86.0, 87.0], "value": 94.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 92.0, 93.0, 93.0, 94.0, 93.0, 105.0, 134.0, 91.0], "value": 98.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 84.0, 84.0, 94.0, 125.0, 85.0, 86.0, 88.0, 86.0], "value": 90.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 54.0, 54.0, 52.0, 53.0, 57.0, 55.0, 57.0, 58.0, 57.0], "value": 55.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 71.0, 72.0, 73.0, 67.0, 68.0, 67.0, 68.0, 69.0], "value": 69.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 83.0, 80.0, 85.0, 82.0, 84.0, 86.0, 90.0, 86.0], "value": 84.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 147.0, 121.0, 149.0, 132.0, 140.0, 147.0, 154.0, 190.0, 152.0], "value": 146.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 163.0, 161.0, 163.0, 164.0, 163.0, 164.0, 166.0, 161.0], "value": 163.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 72.0, 81.0, 88.0, 58.0, 75.0, 83.0, 88.0, 88.0, 86.0], "value": 78.5, "unit": "score"}], "name": "kraken", "value": 1462.7, "alertThreshold": 2.0}]} 07:56:28 INFO - Return code: 0 07:56:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:56:29 INFO - # TBPL SUCCESS # 07:56:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:56:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:56:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:56:29 INFO - 2016-09-30 07:56:29.040 screenresolution[1675:10295] starting screenresolution argv=screenresolution get 07:56:29 INFO - 2016-09-30 07:56:29.043 screenresolution[1675:10295] Display 0: 1600x1200x32@60 07:56:29 INFO - 2016-09-30 07:56:29.049 screenresolution[1676:10298] starting screenresolution argv=screenresolution list 07:56:29 INFO - Available Modes on Display 0 07:56:29 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:56:29 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:56:29 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:56:29 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:56:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:56:29 INFO - Intel Iris: 07:56:29 INFO - Chipset Model: Intel Iris 07:56:29 INFO - Type: GPU 07:56:29 INFO - Bus: Built-In 07:56:29 INFO - VRAM (Dynamic, Max): 1536 MB 07:56:29 INFO - Vendor: Intel (0x8086) 07:56:29 INFO - Device ID: 0x0a2e 07:56:29 INFO - Revision ID: 0x0009 07:56:29 INFO - Displays: 07:56:29 INFO - Display: 07:56:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:56:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:56:29 INFO - Display Serial Number: 1600x1200 60 07:56:29 INFO - Main Display: Yes 07:56:29 INFO - Mirror: Off 07:56:29 INFO - Online: Yes 07:56:29 INFO - Rotation: Supported 07:56:29 INFO - Return code: 0 07:56:29 INFO - Running post-action listener: _resource_record_post_action 07:56:29 INFO - [mozharness: 2016-09-30 14:56:29.303593Z] Finished run-tests step (success) 07:56:29 INFO - Running post-run listener: _resource_record_post_run 07:56:29 INFO - Total resource usage - Wall time: 1210s; CPU: 53.0%; Read bytes: 32930816; Write bytes: 662498304; Read time: 311; Write time: 1994 07:56:29 INFO - TinderboxPrint: CPU usage
53.2% 07:56:29 INFO - TinderboxPrint: I/O read bytes / time
32,930,816 / 311 07:56:29 INFO - TinderboxPrint: I/O write bytes / time
662,498,304 / 1,994 07:56:29 INFO - TinderboxPrint: CPU idle
2,264.4 (46.8%) 07:56:29 INFO - TinderboxPrint: CPU system
966.7 (20.0%) 07:56:29 INFO - TinderboxPrint: CPU user
1,610.6 (33.3%) 07:56:29 INFO - TinderboxPrint: Swap in / out
391,626,752 / 0 07:56:29 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 362332672; Write bytes: 357266432; Read time: 27675; Write time: 693 07:56:29 INFO - run-tests - Wall time: 1178s; CPU: 53.0%; Read bytes: 29174784; Write bytes: 294819840; Read time: 280; Write time: 1265 07:56:29 INFO - Running post-run listener: _upload_blobber_files 07:56:29 INFO - Blob upload gear active. 07:56:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:56:29 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 07:56:29 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:56:29 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:56:30 INFO - (blobuploader) - INFO - Open directory for files ... 07:56:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:56:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:56:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:56:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:56:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:56:31 INFO - (blobuploader) - INFO - Done attempting. 07:56:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:56:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:56:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:56:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:56:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:56:32 INFO - (blobuploader) - INFO - Done attempting. 07:56:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:56:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:56:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:56:34 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:56:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:56:34 INFO - (blobuploader) - INFO - Done attempting. 07:56:34 INFO - (blobuploader) - INFO - Iteration through files over. 07:56:34 INFO - Return code: 0 07:56:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:56:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:56:34 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8fc2f719a1e9353917a2f47a7bfe60436548e990c53867c20f74ddbc4214f0210d7cade8b43898d5bd0ae7084c0fce3092dedb7d07da17870ab0611af8ef8b84", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c125ef231a6697dbeea4922ff99978256d210c48755ebe496170283ffa91d7434369b7abfd9d8f5990f9a2d4fe3addd3433bd7ab81e99e9a673848dc3b578ec6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d0045f3283e112993316e4e11f7d24ce504259990d84dbbaccbfef5e290195a618153dcaa2035142548283163d1e660f3fba0bf0958a5dacf18890cb3ae66ae4"} 07:56:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:56:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:56:34 INFO - Contents: 07:56:34 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8fc2f719a1e9353917a2f47a7bfe60436548e990c53867c20f74ddbc4214f0210d7cade8b43898d5bd0ae7084c0fce3092dedb7d07da17870ab0611af8ef8b84", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c125ef231a6697dbeea4922ff99978256d210c48755ebe496170283ffa91d7434369b7abfd9d8f5990f9a2d4fe3addd3433bd7ab81e99e9a673848dc3b578ec6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d0045f3283e112993316e4e11f7d24ce504259990d84dbbaccbfef5e290195a618153dcaa2035142548283163d1e660f3fba0bf0958a5dacf18890cb3ae66ae4"} 07:56:34 INFO - Running post-run listener: copy_logs_to_upload_dir 07:56:34 INFO - Copying logs to upload dir... 07:56:34 INFO - mkdir: /builds/slave/test/build/upload/logs 07:56:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1271.072153 ========= master_lag: 3.75 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-09-30 07:56:38.169283) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-09-30 07:56:38.173714) ========= 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.lS1UAURRFT/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.vKD3mPWGrw/Listeners TMPDIR=/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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/Mozilla-Aurora/sha512/8fc2f719a1e9353917a2f47a7bfe60436548e990c53867c20f74ddbc4214f0210d7cade8b43898d5bd0ae7084c0fce3092dedb7d07da17870ab0611af8ef8b84", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c125ef231a6697dbeea4922ff99978256d210c48755ebe496170283ffa91d7434369b7abfd9d8f5990f9a2d4fe3addd3433bd7ab81e99e9a673848dc3b578ec6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d0045f3283e112993316e4e11f7d24ce504259990d84dbbaccbfef5e290195a618153dcaa2035142548283163d1e660f3fba0bf0958a5dacf18890cb3ae66ae4"} build_url:https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010983 build_url: 'https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8fc2f719a1e9353917a2f47a7bfe60436548e990c53867c20f74ddbc4214f0210d7cade8b43898d5bd0ae7084c0fce3092dedb7d07da17870ab0611af8ef8b84", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c125ef231a6697dbeea4922ff99978256d210c48755ebe496170283ffa91d7434369b7abfd9d8f5990f9a2d4fe3addd3433bd7ab81e99e9a673848dc3b578ec6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d0045f3283e112993316e4e11f7d24ce504259990d84dbbaccbfef5e290195a618153dcaa2035142548283163d1e660f3fba0bf0958a5dacf18890cb3ae66ae4"}' ========= master_lag: 1.60 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-09-30 07:56:39.783834) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 17 secs) (at 2016-09-30 07:56:39.784159) ========= 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.lS1UAURRFT/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.vKD3mPWGrw/Listeners TMPDIR=/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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.005115 ========= master_lag: 17.55 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 17 secs) (at 2016-09-30 07:56:57.335677) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-30 07:56:57.335951) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-30 07:56:57.338115) ========= ========= Total master_lag: 22.97 =========