builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0113 starttime: 1474621275.31 results: success (0) buildid: 20160923004002 builduid: 23e24c68ec6745a2b02f436d4b1a5e5d revision: bc17447fefc995c71a6a97a5a5a0f19783df5ad1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-23 02:01:15.309140) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-23 02:01:15.309573) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-23 02:01:15.310142) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-23 02:01:15.389952) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 02:01:15.390480) ========= 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.wgDAYsOBUZ/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.W0gnHPR8Pn/Listeners TMPDIR=/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/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-23 02:01:15-- 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% 13.1M=0.001s 2016-09-23 02:01:16 (13.1 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.625562 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 02:01:16.040978) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 02:01:16.041277) ========= 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.wgDAYsOBUZ/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.W0gnHPR8Pn/Listeners TMPDIR=/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/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.028642 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 02:01:16.089606) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-23 02:01:16.089901) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev bc17447fefc995c71a6a97a5a5a0f19783df5ad1 --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 bc17447fefc995c71a6a97a5a5a0f19783df5ad1 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.wgDAYsOBUZ/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.W0gnHPR8Pn/Listeners TMPDIR=/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/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-23 02:01:16,167 truncating revision to first 12 chars 2016-09-23 02:01:16,167 Setting DEBUG logging. 2016-09-23 02:01:16,167 attempt 1/10 2016-09-23 02:01:16,167 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/bc17447fefc9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-23 02:01:17,434 unpacking tar archive at: mozilla-aurora-bc17447fefc9/testing/mozharness/ program finished with exit code 0 elapsedTime=1.544639 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-23 02:01:17.656620) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-23 02:01:17.656926) ========= script_repo_revision: bc17447fefc995c71a6a97a5a5a0f19783df5ad1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-23 02:01:17.657314) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-23 02:01:17.657591) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-23 02:01:17.676420) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-09-23 02:01:17.676688) ========= /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.wgDAYsOBUZ/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.W0gnHPR8Pn/Listeners TMPDIR=/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/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 02:01:17 INFO - MultiFileLogger online at 20160923 02:01:17 in /builds/slave/test 02:01:17 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 02:01:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:01:17 INFO - {'append_to_log': False, 02:01:17 INFO - 'base_work_dir': '/builds/slave/test', 02:01:17 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:01:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:01:17 INFO - 'branch': 'Mozilla-Aurora', 02:01:17 INFO - 'buildbot_json_path': 'buildprops.json', 02:01:17 INFO - 'config_files': ('talos/mac_config.py',), 02:01:17 INFO - 'default_actions': ('clobber', 02:01:17 INFO - 'read-buildbot-config', 02:01:17 INFO - 'download-and-extract', 02:01:17 INFO - 'populate-webroot', 02:01:17 INFO - 'create-virtualenv', 02:01:17 INFO - 'install', 02:01:17 INFO - 'run-tests'), 02:01:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:01:17 INFO - 'download_minidump_stackwalk': True, 02:01:17 INFO - 'download_symbols': 'ondemand', 02:01:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:01:17 INFO - 'tooltool.py': '/tools/tooltool.py', 02:01:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:01:17 INFO - '/tools/misc-python/virtualenv.py')}, 02:01:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:01:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:01:17 INFO - 'installer_path': 'installer.exe', 02:01:17 INFO - 'log_level': 'info', 02:01:17 INFO - 'log_name': 'talos', 02:01:17 INFO - 'log_to_console': True, 02:01:17 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:01:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:01:17 INFO - 'opt_config_files': (), 02:01:17 INFO - 'pip_index': False, 02:01:17 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:01:17 INFO - 'cmd': ('bash', 02:01:17 INFO - '-c', 02:01:17 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:01:17 INFO - 'enabled': True, 02:01:17 INFO - 'halt_on_failure': False, 02:01:17 INFO - 'name': 'check_screen_resolution'},), 02:01:17 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:01:17 INFO - 'cmd': ('bash', 02:01:17 INFO - '-c', 02:01:17 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:01:17 INFO - 'enabled': True, 02:01:17 INFO - 'halt_on_failure': False, 02:01:17 INFO - 'name': 'check_screen_resolution'},), 02:01:17 INFO - 'run_cmd_checks_enabled': True, 02:01:17 INFO - 'sps_profile': False, 02:01:17 INFO - 'sps_profile_interval': 0, 02:01:17 INFO - 'suite': 'dromaeojs', 02:01:17 INFO - 'system_bits': '32', 02:01:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:01:17 INFO - 'title': 't-yosemite-r7-0113', 02:01:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:01:17 INFO - 'use_talos_json': True, 02:01:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:01:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:01:17 INFO - 'work_dir': 'build'} 02:01:17 INFO - [mozharness: 2016-09-23 09:01:17.878458Z] Running clobber step. 02:01:17 INFO - Running pre-action listener: _resource_record_pre_action 02:01:17 INFO - Running main action method: clobber 02:01:17 INFO - rmtree: /builds/slave/test/build 02:01:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:01:19 INFO - Running post-action listener: _resource_record_post_action 02:01:19 INFO - [mozharness: 2016-09-23 09:01:19.968892Z] Finished clobber step (success) 02:01:19 INFO - [mozharness: 2016-09-23 09:01:19.969009Z] Running read-buildbot-config step. 02:01:19 INFO - Running pre-action listener: _resource_record_pre_action 02:01:19 INFO - Running main action method: read_buildbot_config 02:01:19 INFO - Using buildbot properties: 02:01:19 INFO - { 02:01:19 INFO - "project": "", 02:01:19 INFO - "product": "firefox", 02:01:19 INFO - "script_repo_revision": "production", 02:01:19 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 02:01:19 INFO - "repository": "", 02:01:19 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 02:01:19 INFO - "buildid": "20160923004002", 02:01:19 INFO - "stage_platform": "macosx64", 02:01:19 INFO - "basedir": "/builds/slave/test", 02:01:19 INFO - "nightly_build": "True", 02:01:19 INFO - "buildnumber": 54, 02:01:19 INFO - "slavename": "t-yosemite-r7-0113", 02:01:19 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 02:01:19 INFO - "platform": "yosemite_r7", 02:01:19 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 02:01:19 INFO - "branch": "mozilla-aurora", 02:01:19 INFO - "repo_path": "releases/mozilla-aurora", 02:01:19 INFO - "revision": "bc17447fefc995c71a6a97a5a5a0f19783df5ad1", 02:01:19 INFO - "pgo_build": "False", 02:01:19 INFO - "builduid": "23e24c68ec6745a2b02f436d4b1a5e5d", 02:01:19 INFO - "slavebuilddir": "test" 02:01:19 INFO - } 02:01:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/Kz720596ReyKn4TaebBmZw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 02:01:19 INFO - Running post-action listener: _resource_record_post_action 02:01:19 INFO - [mozharness: 2016-09-23 09:01:19.972560Z] Finished read-buildbot-config step (success) 02:01:19 INFO - [mozharness: 2016-09-23 09:01:19.972674Z] Running download-and-extract step. 02:01:19 INFO - Running pre-action listener: _resource_record_pre_action 02:01:19 INFO - Running main action method: download_and_extract 02:01:19 INFO - mkdir: /builds/slave/test/build/tests 02:01:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:01:19 INFO - trying https://queue.taskcluster.net/v1/task/Kz720596ReyKn4TaebBmZw/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 02:01:19 INFO - Downloading https://queue.taskcluster.net/v1/task/Kz720596ReyKn4TaebBmZw/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 02:01:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Kz720596ReyKn4TaebBmZw/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 02:01:20 INFO - Downloaded 1199 bytes. 02:01:20 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 02:01:20 INFO - Using the following test package requirements: 02:01:20 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 02:01:20 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 02:01:20 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 02:01:20 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 02:01:20 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 02:01:20 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 02:01:20 INFO - u'jsshell-mac.zip'], 02:01:20 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 02:01:20 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 02:01:20 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 02:01:20 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 02:01:20 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 02:01:20 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 02:01:20 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 02:01:20 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 02:01:20 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 02:01:20 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 02:01:20 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 02:01:20 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 02:01:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Kz720596ReyKn4TaebBmZw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 02:01:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Kz720596ReyKn4TaebBmZw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:01:20 INFO - Fetch https://queue.taskcluster.net/v1/task/Kz720596ReyKn4TaebBmZw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 02:01:21 INFO - Expected file size: 16426549 02:01:28 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 02:01:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Kz720596ReyKn4TaebBmZw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 02:01:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Kz720596ReyKn4TaebBmZw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:01:28 INFO - Fetch https://queue.taskcluster.net/v1/task/Kz720596ReyKn4TaebBmZw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 02:01:29 INFO - Expected file size: 16426549 02:01:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Kz720596ReyKn4TaebBmZw/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 02:01:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Kz720596ReyKn4TaebBmZw/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 02:01:36 INFO - Fetch https://queue.taskcluster.net/v1/task/Kz720596ReyKn4TaebBmZw/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 02:01:37 INFO - Expected file size: 14414059 02:01:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:01:38 INFO - trying https://queue.taskcluster.net/v1/task/Kz720596ReyKn4TaebBmZw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 02:01:38 INFO - Downloading https://queue.taskcluster.net/v1/task/Kz720596ReyKn4TaebBmZw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 02:01:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Kz720596ReyKn4TaebBmZw/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 02:01:41 INFO - Downloaded 115350984 bytes. 02:01:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Kz720596ReyKn4TaebBmZw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 02:01:41 INFO - mkdir: /builds/slave/test/properties 02:01:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:01:41 INFO - Writing to file /builds/slave/test/properties/build_url 02:01:41 INFO - Contents: 02:01:41 INFO - build_url:https://queue.taskcluster.net/v1/task/Kz720596ReyKn4TaebBmZw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 02:01:42 INFO - Running post-action listener: _resource_record_post_action 02:01:42 INFO - Running post-action listener: set_extra_try_arguments 02:01:42 INFO - [mozharness: 2016-09-23 09:01:42.641720Z] Finished download-and-extract step (success) 02:01:42 INFO - [mozharness: 2016-09-23 09:01:42.641871Z] Running populate-webroot step. 02:01:42 INFO - Running pre-action listener: _resource_record_pre_action 02:01:42 INFO - Running main action method: populate_webroot 02:01:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:01:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:01:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:01:42 INFO - '--tppagecycles', 02:01:42 INFO - '7'], 02:01:42 INFO - 'tests': ['tsvgm']}}, 02:01:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:01:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:01:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:01:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:01:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:01:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:01:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:01:42 INFO - 'talos_options': ['--disable-e10s'], 02:01:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:01:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:01:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:01:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:01:42 INFO - 'talos_options': ['--disable-e10s'], 02:01:42 INFO - 'tests': ['damp', 'tps']}, 02:01:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:01:42 INFO - 'tests': ['damp', 'tps']}, 02:01:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:01:42 INFO - 'tests': ['dromaeo_dom']}, 02:01:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:01:42 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:01:42 INFO - 'tests': ['basic_compositor_video']}, 02:01:42 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:01:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:01:42 INFO - 'tests': ['a11yr', 02:01:42 INFO - 'ts_paint', 02:01:42 INFO - 'tpaint', 02:01:42 INFO - 'sessionrestore', 02:01:42 INFO - 'sessionrestore_no_auto_restore', 02:01:42 INFO - 'tabpaint']}, 02:01:42 INFO - 'other-e10s': {'tests': ['a11yr', 02:01:42 INFO - 'ts_paint', 02:01:42 INFO - 'tpaint', 02:01:42 INFO - 'sessionrestore', 02:01:42 INFO - 'sessionrestore_no_auto_restore', 02:01:42 INFO - 'tabpaint']}, 02:01:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:01:42 INFO - 'ts_paint', 02:01:42 INFO - 'tpaint', 02:01:42 INFO - 'sessionrestore', 02:01:42 INFO - 'sessionrestore_no_auto_restore', 02:01:42 INFO - 'tabpaint']}, 02:01:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:01:42 INFO - 'ts_paint', 02:01:42 INFO - 'tpaint', 02:01:42 INFO - 'sessionrestore', 02:01:42 INFO - 'sessionrestore_no_auto_restore', 02:01:42 INFO - 'tabpaint']}, 02:01:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:01:42 INFO - 'tests': ['a11yr', 02:01:42 INFO - 'ts_paint', 02:01:42 INFO - 'tpaint', 02:01:42 INFO - 'sessionrestore', 02:01:42 INFO - 'sessionrestore_no_auto_restore', 02:01:42 INFO - 'tabpaint']}, 02:01:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:01:42 INFO - 'tests': ['a11yr', 02:01:42 INFO - 'ts_paint', 02:01:42 INFO - 'tpaint', 02:01:42 INFO - 'sessionrestore', 02:01:42 INFO - 'sessionrestore_no_auto_restore', 02:01:42 INFO - 'tabpaint']}, 02:01:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:01:42 INFO - 'tests': ['tsvgx', 02:01:42 INFO - 'tsvgr_opacity', 02:01:42 INFO - 'tart', 02:01:42 INFO - 'tscrollx', 02:01:42 INFO - 'cart']}, 02:01:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:01:42 INFO - 'tsvgr_opacity', 02:01:42 INFO - 'tart', 02:01:42 INFO - 'tscrollx', 02:01:42 INFO - 'cart']}, 02:01:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:01:42 INFO - 'talos_options': ['--disable-e10s'], 02:01:42 INFO - 'tests': ['tp5o']}, 02:01:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:01:42 INFO - 'tests': ['tp5o']}, 02:01:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:01:42 INFO - 'talos_options': ['--disable-e10s', 02:01:42 INFO - '--xperf_path', 02:01:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:01:42 INFO - 'tests': ['tp5n']}, 02:01:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:01:42 INFO - 'talos_options': ['--xperf_path', 02:01:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:01:42 INFO - 'tests': ['tp5n']}}, 02:01:42 INFO - 'talos.zip': {'path': '', 02:01:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:01:42 INFO - Running post-action listener: _resource_record_post_action 02:01:42 INFO - [mozharness: 2016-09-23 09:01:42.660732Z] Finished populate-webroot step (success) 02:01:42 INFO - [mozharness: 2016-09-23 09:01:42.660840Z] Running create-virtualenv step. 02:01:42 INFO - Running pre-action listener: _resource_record_pre_action 02:01:42 INFO - Running main action method: create_virtualenv 02:01:42 INFO - Creating virtualenv /builds/slave/test/build/venv 02:01:42 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 02:01:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:01:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:01:42 INFO - Using real prefix '/tools/python27' 02:01:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:01:43 INFO - Installing distribute.............................................................................................................................................................................................done. 02:01:46 INFO - Installing pip.................done. 02:01:46 INFO - Return code: 0 02:01:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:01:46 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')]} 02:01:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:01:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:46 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')]} 02:01:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:01:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:46 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 0x10fcf4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc6a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd2ac71de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fb08d30>, '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 0x10f96edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fb00b20>, '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.wgDAYsOBUZ/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.W0gnHPR8Pn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/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 02:01:46 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 02:01:46 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 02:01:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wgDAYsOBUZ/Render', 02:01:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:01:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:01:46 INFO - 'HOME': '/Users/cltbld', 02:01:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:01:46 INFO - 'LOGNAME': 'cltbld', 02:01:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:01:46 INFO - 'MOZ_NO_REMOTE': '1', 02:01:46 INFO - 'NO_EM_RESTART': '1', 02:01:46 INFO - 'PAGER': '/bin/cat', 02:01:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:01:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:01:46 INFO - 'PWD': '/builds/slave/test', 02:01:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:01:46 INFO - 'SHELL': '/bin/bash', 02:01:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W0gnHPR8Pn/Listeners', 02:01:46 INFO - 'TMPDIR': '/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/', 02:01:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:01:46 INFO - 'USER': 'cltbld', 02:01:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:01:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:01:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:01:46 INFO - 'XPC_FLAGS': '0x0', 02:01:46 INFO - 'XPC_SERVICE_NAME': '0', 02:01:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:01:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:01:46 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 02:01:46 INFO - Cleaning up... 02:01:46 INFO - Return code: 0 02:01:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:01:46 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')]} 02:01:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:01:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:46 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')]} 02:01:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:01:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:46 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 0x10fcf4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc6a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd2ac71de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fb08d30>, '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 0x10f96edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fb00b20>, '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.wgDAYsOBUZ/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.W0gnHPR8Pn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/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 02:01:46 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 02:01:46 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 02:01:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wgDAYsOBUZ/Render', 02:01:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:01:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:01:46 INFO - 'HOME': '/Users/cltbld', 02:01:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:01:46 INFO - 'LOGNAME': 'cltbld', 02:01:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:01:46 INFO - 'MOZ_NO_REMOTE': '1', 02:01:46 INFO - 'NO_EM_RESTART': '1', 02:01:46 INFO - 'PAGER': '/bin/cat', 02:01:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:01:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:01:46 INFO - 'PWD': '/builds/slave/test', 02:01:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:01:46 INFO - 'SHELL': '/bin/bash', 02:01:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W0gnHPR8Pn/Listeners', 02:01:46 INFO - 'TMPDIR': '/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/', 02:01:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:01:46 INFO - 'USER': 'cltbld', 02:01:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:01:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:01:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:01:46 INFO - 'XPC_FLAGS': '0x0', 02:01:46 INFO - 'XPC_SERVICE_NAME': '0', 02:01:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:01:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:01:46 INFO - Downloading/unpacking psutil>=3.1.1 02:01:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:01:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:01:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:01:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:01:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:01:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:01:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:01:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:01:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:01:50 INFO - Installing collected packages: psutil 02:01:50 INFO - Running setup.py install for psutil 02:01:51 INFO - building 'psutil._psutil_osx' extension 02:01:51 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 02:01:51 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 02:01:51 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 02:01:51 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 02:01:51 INFO - building 'psutil._psutil_posix' extension 02:01:51 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 02:01:51 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:01:51 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:01:51 INFO - ^ 02:01:51 INFO - 1 warning generated. 02:01:51 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 02:01:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:01:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:01:52 INFO - Successfully installed psutil 02:01:52 INFO - Cleaning up... 02:01:52 INFO - Return code: 0 02:01:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:01:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:01:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:01:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:01:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:01:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:52 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 0x10fcf4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc6a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd2ac71de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fb08d30>, '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 0x10f96edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fb00b20>, '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.wgDAYsOBUZ/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.W0gnHPR8Pn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/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 02:01:52 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 02:01:52 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 02:01:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wgDAYsOBUZ/Render', 02:01:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:01:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:01:52 INFO - 'HOME': '/Users/cltbld', 02:01:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:01:52 INFO - 'LOGNAME': 'cltbld', 02:01:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:01:52 INFO - 'MOZ_NO_REMOTE': '1', 02:01:52 INFO - 'NO_EM_RESTART': '1', 02:01:52 INFO - 'PAGER': '/bin/cat', 02:01:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:01:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:01:52 INFO - 'PWD': '/builds/slave/test', 02:01:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:01:52 INFO - 'SHELL': '/bin/bash', 02:01:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W0gnHPR8Pn/Listeners', 02:01:52 INFO - 'TMPDIR': '/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/', 02:01:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:01:52 INFO - 'USER': 'cltbld', 02:01:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:01:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:01:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:01:52 INFO - 'XPC_FLAGS': '0x0', 02:01:52 INFO - 'XPC_SERVICE_NAME': '0', 02:01:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:01:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:01:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:01:52 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 02:01:52 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 02:01:52 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 02:01:52 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 02:01:52 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 02:01:52 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 02:01:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:01:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:01:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:01:55 INFO - Installing collected packages: mozsystemmonitor 02:01:55 INFO - Running setup.py install for mozsystemmonitor 02:01:55 INFO - Successfully installed mozsystemmonitor 02:01:55 INFO - Cleaning up... 02:01:55 INFO - Return code: 0 02:01:55 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:01:55 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')]} 02:01:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:01:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:55 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')]} 02:01:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:01:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:55 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 0x10fcf4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc6a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd2ac71de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fb08d30>, '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 0x10f96edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fb00b20>, '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.wgDAYsOBUZ/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.W0gnHPR8Pn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/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 02:01:55 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 02:01:55 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 02:01:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wgDAYsOBUZ/Render', 02:01:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:01:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:01:55 INFO - 'HOME': '/Users/cltbld', 02:01:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:01:55 INFO - 'LOGNAME': 'cltbld', 02:01:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:01:55 INFO - 'MOZ_NO_REMOTE': '1', 02:01:55 INFO - 'NO_EM_RESTART': '1', 02:01:55 INFO - 'PAGER': '/bin/cat', 02:01:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:01:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:01:55 INFO - 'PWD': '/builds/slave/test', 02:01:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:01:55 INFO - 'SHELL': '/bin/bash', 02:01:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W0gnHPR8Pn/Listeners', 02:01:55 INFO - 'TMPDIR': '/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/', 02:01:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:01:55 INFO - 'USER': 'cltbld', 02:01:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:01:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:01:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:01:55 INFO - 'XPC_FLAGS': '0x0', 02:01:55 INFO - 'XPC_SERVICE_NAME': '0', 02:01:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:01:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:01:55 INFO - Downloading/unpacking jsonschema==2.5.1 02:01:55 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 02:01:55 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 02:01:55 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 02:01:55 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 02:01:55 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 02:01:55 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 02:01:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:01:57 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:01:57 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 02:01:57 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 02:01:57 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 02:01:57 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 02:01:57 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 02:01:57 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 02:01:58 INFO - Downloading functools32-3.2.3-2.tar.gz 02:01:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:01:58 INFO - warning: no files found matching '*.txt' 02:01:58 INFO - no previously-included directories found matching 'build' 02:01:58 INFO - no previously-included directories found matching 'dist' 02:01:58 INFO - no previously-included directories found matching '.git*' 02:01:58 INFO - Installing collected packages: jsonschema, functools32 02:01:58 INFO - Running setup.py install for functools32 02:01:58 INFO - warning: no files found matching '*.txt' 02:01:58 INFO - no previously-included directories found matching 'build' 02:01:58 INFO - no previously-included directories found matching 'dist' 02:01:58 INFO - no previously-included directories found matching '.git*' 02:01:58 INFO - Successfully installed jsonschema functools32 02:01:58 INFO - Cleaning up... 02:01:58 INFO - Return code: 0 02:01:58 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:01:58 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')]} 02:01:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:01:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:58 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')]} 02:01:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:01:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:58 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 0x10fcf4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc6a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd2ac71de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fb08d30>, '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 0x10f96edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fb00b20>, '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.wgDAYsOBUZ/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.W0gnHPR8Pn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/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 02:01:58 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 02:01:58 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 02:01:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wgDAYsOBUZ/Render', 02:01:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:01:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:01:58 INFO - 'HOME': '/Users/cltbld', 02:01:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:01:58 INFO - 'LOGNAME': 'cltbld', 02:01:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:01:58 INFO - 'MOZ_NO_REMOTE': '1', 02:01:58 INFO - 'NO_EM_RESTART': '1', 02:01:58 INFO - 'PAGER': '/bin/cat', 02:01:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:01:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:01:58 INFO - 'PWD': '/builds/slave/test', 02:01:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:01:58 INFO - 'SHELL': '/bin/bash', 02:01:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W0gnHPR8Pn/Listeners', 02:01:58 INFO - 'TMPDIR': '/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/', 02:01:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:01:58 INFO - 'USER': 'cltbld', 02:01:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:01:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:01:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:01:58 INFO - 'XPC_FLAGS': '0x0', 02:01:58 INFO - 'XPC_SERVICE_NAME': '0', 02:01:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:01:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:01:58 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:01:58 INFO - Cleaning up... 02:01:58 INFO - Return code: 0 02:01:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:01:58 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')]} 02:01:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:01:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:58 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')]} 02:01:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:01:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:58 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 0x10fcf4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc6a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd2ac71de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fb08d30>, '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 0x10f96edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fb00b20>, '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.wgDAYsOBUZ/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.W0gnHPR8Pn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/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 02:01:58 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 02:01:58 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 02:01:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wgDAYsOBUZ/Render', 02:01:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:01:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:01:58 INFO - 'HOME': '/Users/cltbld', 02:01:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:01:58 INFO - 'LOGNAME': 'cltbld', 02:01:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:01:58 INFO - 'MOZ_NO_REMOTE': '1', 02:01:58 INFO - 'NO_EM_RESTART': '1', 02:01:58 INFO - 'PAGER': '/bin/cat', 02:01:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:01:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:01:58 INFO - 'PWD': '/builds/slave/test', 02:01:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:01:58 INFO - 'SHELL': '/bin/bash', 02:01:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W0gnHPR8Pn/Listeners', 02:01:58 INFO - 'TMPDIR': '/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/', 02:01:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:01:58 INFO - 'USER': 'cltbld', 02:01:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:01:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:01:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:01:58 INFO - 'XPC_FLAGS': '0x0', 02:01:58 INFO - 'XPC_SERVICE_NAME': '0', 02:01:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:01:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:01:59 INFO - Downloading/unpacking blobuploader==1.2.4 02:01: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 02:01: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 02:01: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 02:01: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 02:01: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 02:01: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 02:02:01 INFO - Downloading blobuploader-1.2.4.tar.gz 02:02:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:02:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:02:01 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 02:02:01 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 02:02:01 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 02:02:01 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 02:02:01 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 02:02:01 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 02:02:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:02:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:02: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 02:02: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 02:02: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 02:02: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 02:02: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 02:02: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 02:02:02 INFO - Downloading docopt-0.6.1.tar.gz 02:02:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:02:02 INFO - Installing collected packages: blobuploader, requests, docopt 02:02:02 INFO - Running setup.py install for blobuploader 02:02:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:02:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:02:03 INFO - Running setup.py install for requests 02:02:03 INFO - Running setup.py install for docopt 02:02:03 INFO - Successfully installed blobuploader requests docopt 02:02:03 INFO - Cleaning up... 02:02:03 INFO - Return code: 0 02:02:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:02: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')]} 02:02:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:02:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02: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')]} 02:02:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:02:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:03 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 0x10fcf4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc6a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd2ac71de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fb08d30>, '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 0x10f96edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fb00b20>, '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.wgDAYsOBUZ/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.W0gnHPR8Pn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/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 02:02:03 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 02:02:03 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 02:02:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wgDAYsOBUZ/Render', 02:02:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:02:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:02:03 INFO - 'HOME': '/Users/cltbld', 02:02:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:02:03 INFO - 'LOGNAME': 'cltbld', 02:02:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:02:03 INFO - 'MOZ_NO_REMOTE': '1', 02:02:03 INFO - 'NO_EM_RESTART': '1', 02:02:03 INFO - 'PAGER': '/bin/cat', 02:02:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:02:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:02:03 INFO - 'PWD': '/builds/slave/test', 02:02:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:02:03 INFO - 'SHELL': '/bin/bash', 02:02:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W0gnHPR8Pn/Listeners', 02:02:03 INFO - 'TMPDIR': '/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/', 02:02:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:02:03 INFO - 'USER': 'cltbld', 02:02:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:02:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:02:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:02:03 INFO - 'XPC_FLAGS': '0x0', 02:02:03 INFO - 'XPC_SERVICE_NAME': '0', 02:02:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:02:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:02:04 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-zLkOdQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:02:04 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-N5iX_G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:02:04 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-0xQrAQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:02:04 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-sCr42J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:02:04 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-T2T2De-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:02:04 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-CXi2sp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:02:04 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-V5FWNe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:02:04 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-DQsgql-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:02:04 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-a5LfOI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:02:05 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-03YFjj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:02:05 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-Az_z4Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:02:05 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-2ikZ8b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:02:05 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-rVgCEf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:02:05 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-WPkG0y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:02:05 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-kYirzw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:02:05 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-QdE6E6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:02:05 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-LLipzn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:02:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:02:05 INFO - Running setup.py install for manifestparser 02:02:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:02:06 INFO - Running setup.py install for mozcrash 02:02:06 INFO - Running setup.py install for mozdebug 02:02:06 INFO - Running setup.py install for mozdevice 02:02:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:02:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:02:06 INFO - Running setup.py install for mozfile 02:02:06 INFO - Running setup.py install for mozhttpd 02:02:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:02:06 INFO - Running setup.py install for mozinfo 02:02:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:02:06 INFO - Running setup.py install for mozInstall 02:02:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:02:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:02:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:02:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:02:07 INFO - Running setup.py install for mozleak 02:02:07 INFO - Running setup.py install for mozlog 02:02:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:02:07 INFO - Running setup.py install for moznetwork 02:02:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:02:07 INFO - Running setup.py install for mozprocess 02:02:07 INFO - Running setup.py install for mozprofile 02:02:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:02:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:02:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:02:07 INFO - Running setup.py install for mozrunner 02:02:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:02:08 INFO - Running setup.py install for mozscreenshot 02:02:08 INFO - Running setup.py install for moztest 02:02:08 INFO - Running setup.py install for mozversion 02:02:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:02:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:02:08 INFO - Cleaning up... 02:02:08 INFO - Return code: 0 02:02:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:02: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')]} 02:02:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:02:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02: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')]} 02:02:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:02:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:08 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 0x10fcf4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc6a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd2ac71de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fb08d30>, '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 0x10f96edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fb00b20>, '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.wgDAYsOBUZ/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.W0gnHPR8Pn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/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 02:02:08 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 02:02:08 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 02:02:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wgDAYsOBUZ/Render', 02:02:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:02:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:02:08 INFO - 'HOME': '/Users/cltbld', 02:02:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:02:08 INFO - 'LOGNAME': 'cltbld', 02:02:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:02:08 INFO - 'MOZ_NO_REMOTE': '1', 02:02:08 INFO - 'NO_EM_RESTART': '1', 02:02:08 INFO - 'PAGER': '/bin/cat', 02:02:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:02:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:02:08 INFO - 'PWD': '/builds/slave/test', 02:02:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:02:08 INFO - 'SHELL': '/bin/bash', 02:02:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W0gnHPR8Pn/Listeners', 02:02:08 INFO - 'TMPDIR': '/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/', 02:02:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:02:08 INFO - 'USER': 'cltbld', 02:02:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:02:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:02:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:02:08 INFO - 'XPC_FLAGS': '0x0', 02:02:08 INFO - 'XPC_SERVICE_NAME': '0', 02:02:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:02:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:02:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:02:08 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-8AK6N7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:02:08 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)) 02:02:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:02:08 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-h5R7HC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:02:08 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)) 02:02:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:02:08 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-iL25Vh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:02:09 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)) 02:02:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:02:09 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-JYdokb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:02:09 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)) 02:02:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:02:09 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-9jHtqG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:02:09 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)) 02:02:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:02:09 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-Amr8d2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:02:09 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)) 02:02:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:02:09 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-MfI2u6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:02:09 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)) 02:02:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:02:09 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-M_fdJM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:02:09 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)) 02:02:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:02:09 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-rbFTMv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:02:09 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)) 02:02:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:02:09 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-zZptp5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:02:09 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)) 02:02:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:02:09 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-jEijN4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:02:09 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)) 02:02:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:02:09 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-Hy2t4K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:02:10 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)) 02:02:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:02:10 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-Hj0uRN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:02:10 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)) 02:02:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:02:10 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-fHiVO7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:02:10 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)) 02:02:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:02:10 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-lN0cGJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:02:10 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)) 02:02:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:02:10 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-oOKjpH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:02:10 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)) 02:02:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:02:10 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-osewii-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:02:10 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)) 02:02:10 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)) 02:02:10 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)) 02:02:10 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)) 02:02:10 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)) 02:02:10 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)) 02:02:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:02:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:02:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:02:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:02:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:02:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:02:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:02:13 INFO - Downloading blessings-1.6.tar.gz 02:02:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:02:13 INFO - Installing collected packages: blessings 02:02:13 INFO - Running setup.py install for blessings 02:02:13 INFO - Successfully installed blessings 02:02:13 INFO - Cleaning up... 02:02:13 INFO - Return code: 0 02:02:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:02:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:02:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:02:13 INFO - Reading from file tmpfile_stdout 02:02:13 INFO - Current package versions: 02:02:13 INFO - blessings == 1.6 02:02:13 INFO - blobuploader == 1.2.4 02:02:13 INFO - docopt == 0.6.1 02:02:13 INFO - functools32 == 3.2.3-2 02:02:13 INFO - jsonschema == 2.5.1 02:02:13 INFO - manifestparser == 1.1 02:02:13 INFO - mozInstall == 1.12 02:02:13 INFO - mozcrash == 0.17 02:02:13 INFO - mozdebug == 0.1 02:02:13 INFO - mozdevice == 0.48 02:02:13 INFO - mozfile == 1.2 02:02:13 INFO - mozhttpd == 0.7 02:02:13 INFO - mozinfo == 0.9 02:02:13 INFO - mozleak == 0.1 02:02:13 INFO - mozlog == 3.4 02:02:13 INFO - moznetwork == 0.27 02:02:13 INFO - mozprocess == 0.23 02:02:13 INFO - mozprofile == 0.28 02:02:13 INFO - mozrunner == 6.12 02:02:13 INFO - mozscreenshot == 0.1 02:02:13 INFO - mozsystemmonitor == 0.3 02:02:13 INFO - moztest == 0.7 02:02:13 INFO - mozversion == 1.4 02:02:13 INFO - psutil == 3.1.1 02:02:13 INFO - requests == 1.2.3 02:02:13 INFO - wsgiref == 0.1.2 02:02:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:02:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:02:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:02:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:02:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:02:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:13 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 0x10fcf4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc6a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd2ac71de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fb08d30>, '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 0x10f96edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fb00b20>, '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.wgDAYsOBUZ/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.W0gnHPR8Pn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/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 02:02:13 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 02:02:13 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 02:02:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wgDAYsOBUZ/Render', 02:02:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:02:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:02:13 INFO - 'HOME': '/Users/cltbld', 02:02:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:02:13 INFO - 'LOGNAME': 'cltbld', 02:02:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:02:13 INFO - 'MOZ_NO_REMOTE': '1', 02:02:13 INFO - 'NO_EM_RESTART': '1', 02:02:13 INFO - 'PAGER': '/bin/cat', 02:02:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:02:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:02:13 INFO - 'PWD': '/builds/slave/test', 02:02:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:02:13 INFO - 'SHELL': '/bin/bash', 02:02:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W0gnHPR8Pn/Listeners', 02:02:13 INFO - 'TMPDIR': '/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/', 02:02:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:02:13 INFO - 'USER': 'cltbld', 02:02:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:02:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:02:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:02:13 INFO - 'XPC_FLAGS': '0x0', 02:02:13 INFO - 'XPC_SERVICE_NAME': '0', 02:02:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:02:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:02:13 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)) 02:02:13 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)) 02:02:13 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)) 02:02:13 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)) 02:02:13 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)) 02:02:13 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)) 02:02:13 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)) 02:02:13 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)) 02:02:13 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)) 02:02:13 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)) 02:02:13 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)) 02:02:13 INFO - Cleaning up... 02:02:13 INFO - Return code: 0 02:02:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:02:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:02:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:02:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:02:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:02:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:13 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 0x10fcf4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc6a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd2ac71de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fb08d30>, '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 0x10f96edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fb00b20>, '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.wgDAYsOBUZ/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.W0gnHPR8Pn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/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 02:02:13 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 02:02:13 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 02:02:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wgDAYsOBUZ/Render', 02:02:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:02:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:02:13 INFO - 'HOME': '/Users/cltbld', 02:02:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:02:13 INFO - 'LOGNAME': 'cltbld', 02:02:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:02:13 INFO - 'MOZ_NO_REMOTE': '1', 02:02:13 INFO - 'NO_EM_RESTART': '1', 02:02:13 INFO - 'PAGER': '/bin/cat', 02:02:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:02:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:02:13 INFO - 'PWD': '/builds/slave/test', 02:02:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:02:13 INFO - 'SHELL': '/bin/bash', 02:02:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W0gnHPR8Pn/Listeners', 02:02:13 INFO - 'TMPDIR': '/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/', 02:02:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:02:13 INFO - 'USER': 'cltbld', 02:02:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:02:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:02:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:02:13 INFO - 'XPC_FLAGS': '0x0', 02:02:13 INFO - 'XPC_SERVICE_NAME': '0', 02:02:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:02:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:02:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:02:14 INFO - Cleaning up... 02:02:14 INFO - Return code: 0 02:02:14 INFO - Running post-action listener: _resource_record_post_action 02:02:14 INFO - Running post-action listener: _start_resource_monitoring 02:02:14 INFO - Starting resource monitoring. 02:02:14 INFO - [mozharness: 2016-09-23 09:02:14.281354Z] Finished create-virtualenv step (success) 02:02:14 INFO - [mozharness: 2016-09-23 09:02:14.282318Z] Running install step. 02:02:14 INFO - Running pre-action listener: _resource_record_pre_action 02:02:14 INFO - Running main action method: install 02:02:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:02:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:02:14 INFO - Reading from file tmpfile_stdout 02:02:14 INFO - Detecting whether we're running mozinstall >=1.0... 02:02:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:02:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:02:14 INFO - Reading from file tmpfile_stdout 02:02:14 INFO - Output received: 02:02:14 INFO - Usage: mozinstall [options] installer 02:02:14 INFO - Options: 02:02:14 INFO - -h, --help show this help message and exit 02:02:14 INFO - -d DEST, --destination=DEST 02:02:14 INFO - Directory to install application into. [default: 02:02:14 INFO - "/builds/slave/test"] 02:02:14 INFO - --app=APP Application being installed. [default: firefox] 02:02:14 INFO - mkdir: /builds/slave/test/build/application 02:02:14 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'] 02:02:14 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 02:02:47 INFO - Reading from file tmpfile_stdout 02:02:47 INFO - Output received: 02:02:47 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 02:02:47 INFO - Running post-action listener: _resource_record_post_action 02:02:47 INFO - [mozharness: 2016-09-23 09:02:47.083000Z] Finished install step (success) 02:02:47 INFO - [mozharness: 2016-09-23 09:02:47.083142Z] Running run-tests step. 02:02:47 INFO - Running pre-action listener: _resource_record_pre_action 02:02:47 INFO - Running main action method: run_tests 02:02:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:02:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:02:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:02:47 INFO - 2016-09-23 02:02:47.097 screenresolution[1650:8957] starting screenresolution argv=screenresolution get 02:02:47 INFO - 2016-09-23 02:02:47.100 screenresolution[1650:8957] Display 0: 1600x1200x32@60 02:02:47 INFO - 2016-09-23 02:02:47.106 screenresolution[1651:8959] starting screenresolution argv=screenresolution list 02:02:47 INFO - Available Modes on Display 0 02:02:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:02:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:02:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:02:47 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:02:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:02:47 INFO - Intel Iris: 02:02:47 INFO - Chipset Model: Intel Iris 02:02:47 INFO - Type: GPU 02:02:47 INFO - Bus: Built-In 02:02:47 INFO - VRAM (Dynamic, Max): 1536 MB 02:02:47 INFO - Vendor: Intel (0x8086) 02:02:47 INFO - Device ID: 0x0a2e 02:02:47 INFO - Revision ID: 0x0009 02:02:47 INFO - Displays: 02:02:47 INFO - Display: 02:02:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:02:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:02:47 INFO - Display Serial Number: 1600x1200 60 02:02:47 INFO - Main Display: Yes 02:02:47 INFO - Mirror: Off 02:02:47 INFO - Online: Yes 02:02:47 INFO - Rotation: Supported 02:02:47 INFO - Return code: 0 02:02:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:02:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:02:47 INFO - Python 2.7.3 02:02:47 INFO - Return code: 0 02:02:47 INFO - grabbing minidump binary from tooltool 02:02:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:02:47 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 0x10fb08d30>, '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 0x10f96edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fb00b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:02:47 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 02:02:47 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 02:02:47 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 02:02:47 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:02:47 INFO - Return code: 0 02:02:47 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:02:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:02:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:02:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:02:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:02:47 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/Kz720596ReyKn4TaebBmZw/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0113', '--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 02:02:47 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/Kz720596ReyKn4TaebBmZw/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0113 --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 02:02:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wgDAYsOBUZ/Render', 02:02:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:02:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:02:47 INFO - 'HOME': '/Users/cltbld', 02:02:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:02:47 INFO - 'LOGNAME': 'cltbld', 02:02:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:02:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:02:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:02:47 INFO - 'MOZ_NO_REMOTE': '1', 02:02:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:02:47 INFO - 'NO_EM_RESTART': '1', 02:02:47 INFO - 'PAGER': '/bin/cat', 02:02:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:02:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:02:47 INFO - 'PWD': '/builds/slave/test', 02:02:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:02:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:02:47 INFO - 'SHELL': '/bin/bash', 02:02:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W0gnHPR8Pn/Listeners', 02:02:47 INFO - 'TMPDIR': '/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/', 02:02:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:02:47 INFO - 'USER': 'cltbld', 02:02:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:02:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:02:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:02:47 INFO - 'XPC_FLAGS': '0x0', 02:02:47 INFO - 'XPC_SERVICE_NAME': '0', 02:02:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:02:47 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/Kz720596ReyKn4TaebBmZw/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0113', '--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 02:02:47 INFO - mozversion application_buildid: 20160923004002 02:02:47 INFO - mozversion application_changeset: bc17447fefc995c71a6a97a5a5a0f19783df5ad1 02:02:47 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:02:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:02:47 INFO - mozversion application_name: Firefox 02:02:47 INFO - mozversion application_remotingname: firefox-dev 02:02:47 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:02:47 INFO - mozversion application_vendor: Mozilla 02:02:47 INFO - mozversion application_version: 51.0a2 02:02:47 INFO - mozversion platform_buildid: 20160923004002 02:02:47 INFO - mozversion platform_changeset: bc17447fefc995c71a6a97a5a5a0f19783df5ad1 02:02:47 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:02:47 INFO - mozversion platform_version: 51.0a2 02:02:47 INFO - using testdate: 1474621367 02:02:47 INFO - actual date: 1474621367 02:02:47 INFO - starting webserver on 'localhost:49272' 02:02:47 INFO - SUITE-START | Running 2 tests 02:02:47 INFO - TEST-START | dromaeo_css 02:02:47 INFO - operating with platform_type : mac_ 02:02:47 INFO - Initialising browser for dromaeo_css test... 02:02:47 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/tmpoRb0xu/profile http://localhost:49272/getInfo.html) 02:02:50 INFO - PROCESS | 1661 | __metrics Screen width/height:1600/1200 02:02:50 INFO - PROCESS | 1661 | colorDepth:24 02:02:50 INFO - PROCESS | 1661 | Browser inner width/height: 1024/689 02:02:50 INFO - PROCESS | 1661 | __metrics 02:02:50 INFO - PROCESS | 1661 | 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" 02:02:50 INFO - PROCESS | 1661 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:02:51 INFO - TEST-INFO | 1661: exit 0 02:02:51 INFO - Browser initialized. 02:02:51 INFO - Running cycle 1/1 for dromaeo_css test... 02:02:51 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/tmpoRb0xu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:03:03 INFO - PROCESS | 1665 | RSS: Main: 235929600 02:03:03 INFO - PROCESS | 1665 | 02:03:56 INFO - PROCESS | 1665 | 1474621436425 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] 02:06:06 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49272/tests/dromaeo/cssquery-ext.html) 02:06:07 INFO - PROCESS | 1665 | RSS: Main: 378556416 02:06:07 INFO - PROCESS | 1665 | 02:09:10 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-ext.html (next: http://localhost:49272/tests/dromaeo/cssquery-jquery.html) 02:09:11 INFO - PROCESS | 1665 | RSS: Main: 367247360 02:09:11 INFO - PROCESS | 1665 | 02:12:13 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49272/tests/dromaeo/cssquery-mootools.html) 02:12:14 INFO - PROCESS | 1665 | RSS: Main: 347037696 02:12:14 INFO - PROCESS | 1665 | 02:15:16 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49272/tests/dromaeo/cssquery-prototype.html) 02:15:17 INFO - PROCESS | 1665 | RSS: Main: 331730944 02:15:17 INFO - PROCESS | 1665 | 02:18:20 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49272/tests/dromaeo/cssquery-yui.html) 02:18:21 INFO - PROCESS | 1665 | RSS: Main: 325341184 02:18:21 INFO - PROCESS | 1665 | 02:21:24 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-yui.html (next: http://localhost:49272/tests/dromaeo/cssquery-dojo.html) 02:21:24 INFO - PROCESS | 1665 | RSS: Main: 488144896 02:21:24 INFO - PROCESS | 1665 | 02:21:24 INFO - PROCESS | 1665 | __start_tp_report 02:21:24 INFO - PROCESS | 1665 | _x_x_mozilla_page_load 02:21:24 INFO - PROCESS | 1665 | _x_x_mozilla_page_load_details 02:21:24 INFO - PROCESS | 1665 | |i|pagename|runs| 02:21:24 INFO - PROCESS | 1665 | |0;dojo.html;2929.3116117712334;3308.17295676081;3327.168207948013;3343.1809206744365;3368.1747971746927;5622.044252477079;5758.856028599282;5777.248957635502;5792.102224155263;5799.681017544044;5635.63368381056;5679.545636349092;5807.680577568232;5818.0109381405155;5826.9708651456785;5245;5278.788848446067;5289.603279754015;5293.841184764463;5338.839834804962;5206.7917283308625;5223.947760522384;5345.625806193568;5359.7320133993335;5396.730163491829;5262.736863156846;5315.654482458647;5322.920156197641;5323.307969963899;5327.174287985349;5208.557272631812;5242.1088414969545;5278.208268759717;5290.232916227144;5312.840614781524;4643.048175124091;5093.694378337312;5225.817096401608;5287.312649355597;5293.947060529384;5777.335606405233;5809.593328467009;5918.112283157518;5918.881622367571;5977.282726072899;5178.378594568676;5185.144451165553;6117.541184411187;6138.07928810682;6139.3388173831445;6250.9998400255745;6280.685965701697;6302.87394252117;6304.716287767062;6329.145565348711;5835.4748072673665;5849.239598852122;5859.1797148399255;5869.178315035899;5909.970450147722;6214.285357183891;6218.284897236786;6253.937460625427;6270.6864656766975;6288.245410550671;6203.2245969253845;6210.937890621126;6222.502199824004;6230.158928544679;6239.563230573907;6163.96918015416;6290.716917738713;6312.0531920211415;6325.462335701517;6326.051092336094;6097.695115244309;6108.129596501707;6131.437835141539;6305.14880491137;6320.71556779946;6175.505959523227;6196.3803619638575;6243.157173781481;6315.936840631627;6319.747210111636;4983.900321993612;4995.150824359867;5001.149804533238;5003.899142188713;5010.69935803853;4370.606645401929;4388.363687265392;4482.708623939434;4485.618722408632;4496.730196188174;5708.372079071299;5755.740991655385;5762.1068734346245;5795.1886735857015;5875.941240587625;6249.437550620466;6274.341194174637;6295.5907865988565;6303.36966303366;6309.526785491106;5799.507041901401;5799.652020878761;5822.417758224144;5828.184054232411;5858.414158584193;5285.894282114336;5302.973485132549;5356.4107948125675;5356.91964620531;5399.946000540023;6322.304546499881;6322.589031712924;6330.8417289567205;6331.841703957438;6340.587861788969;6261.3112557617715;6305;6308.400701933309;6314.778982735582;6315.842103947438;6188.566800323934;6214.2853571838;6257.812265632038;6284.340144284784;6322.747090116344;6133.38666133401;6229.844253893689;6269.49844012487;6274.560780745304;6279.434850863444;6313.368663133833;6316.936830631635;6325.620462772248;6328.082428047999;6339.936600633934;5959.821205363846;5990.910136347871;6087.117367981529;6168.167297414791;6172.598781079216;6082.635041897501;6099.451049405575;6119.051547010221;6171.814845554641;6207.503399728102;5782.595218334676;6037.486813620892;6047.0627052806885;6047.727852246571;6050.941085310141;5971.731272092853;6079.544034197364;6153.630782152906;6158.107074474086;6171.228596425447;5875.882482350415;5923.052311630118;5947.851303717442;5961.850953726192;6066.090086486885 02:21:24 INFO - PROCESS | 1665 | |1;ext.html;442.58176023657614;474.9382580264566;503.514108884926;524.4205153305597;525.61104782461;30752.84623576882;40900.59099409005;42298;42403.363949540704;42628.78685606575;42386.72839814803;43631;43907.34138987918;44032;44058.77970610151;8801.251893589053;8938;10064.446455444948;10076.244281678866;10095.798084038315;8767.342449316295;8978.910210897873;9904.900950990506;11870.46582903767;12192.207506512093;12149.02807775376;12155.513779448811;12168.627117712049;12171.33057681827;12207.938960305186;12268.877311226863;12322.507099716;12342.75314493714;12360.196587221802;12373.319467429288;11910.523579056913;11977.760444791056;11997.700057498545;12006.63980080599;12016.519339226508;40990.59009409927;41282.38076428856;41334.58665413367;41361.79319103385;41369.58630413718;3504.9299014019575;3574.3208790329754;3978.661813745835;4017.377306517465;4074.124063326399;29733.702662973308;29780.553291700642;29786.95745648892;31771;31775.84112079448;3217.8391080445886;3294.769366144371;3326.600807903043;3435.862565497377;3441.6214216436174;497206.9999999964;503761;504689;506439;506530.4673476646;33433.33133337319;33944.66055339415;33993.32013359719;35183.64816351804;60132.79734405287;35446.64553354433;35536.289274214374;35552.466712999325;35587.4661880072;35608;14735.263236838115;14954;14963.027403218755;14988.775168372484;15042.398304067934;11482.253653512495;12643.557475488315;12735.745285094246;12741.426635801412;12744.61766147017;7198.49610527258;7335.229800870939;7347.37547308474;7350.7427240046345;7359.1169059713175;3171.8255495947483;3206.9839650801596;3208.3102133041507;3248.2366643838677;3256.4301247281633;965.0735294117585;972.9416235025922;976.1848856205148;1054.651964851597;1107.8818590555647;28828.423431531253;29730.55404168896;30108.84945575258;30808;30815.610282869315;835.7994081420537;949.3354651743807;956.7368973532334;1126.267925848189;1231.815227715832;14734.042287251294;15863.920680396755;16207.837921620869;16256;16297.91851040761;703389;712473;713851;715174;715905.8409415943;49730;50544.747276263384;57892.8421431569;58373.416265837644;58800;1372.670559065817;1381.1436909116212;1409.7251036047871;1419.1343280598826;1420.2259768426231;29884.252893677833;31115.68884311128;31387.686123138476;31457.05628831139;32268.677313226566;50747.985040299725;51261.48738512716;51266.74366628143;51458.742706286226;51486.74256628843;900207;930071;931448;934874;936787;40584;40935.59064409318;41224.38163427611;41338;42287.788561057;45870;45949.09432698124;46071.07857842757;46664;46904.765476172404;36902.8154859224;37790.43314350342;38758.61241387663;39806.40290395589;39998.40002399908;37686.434703480016;38279.617203827605;38622.841314760604;39554.802225988686;39695.80152099221;37335.43996840104;37860.24279514449;38017.429738553394;38093.80953095217;38161.80919095387;29547.409051818413;31366.372672545964;33399.81305701784;34145.82927085448;34162;21726.45683857916;22947;24519.509609807348;25163.74836251614;25775.484490310464 02:21:24 INFO - PROCESS | 1665 | |2;jquery.html;353.48391348631;374.7189607794154;375.0941476334652;387.27579426472494;405.98173082211315;15343.38626454942;15420.074795512262;17373.30506779729;20370.59258814823;20826.630121750157;20030.69953950692;21043.78956210441;21128.260510882123;21260.468488287763;21520.354389368345;4911.729854857981;5810.099434587624;5905.468507834294;6167.321594624587;6170.259568851721;5954.255718035246;6132.110843927628;6133.478654314388;6134.662593557375;6156.84607884802;5796.391378905218;5982.042873140298;6035.155078289043;6082.695865206744;6090.969545152268;5909.025010873201;5954.4938680212235;5960.672163031031;5964.135200395962;5964.314103878066;5198.688078715251;5232.293640358541;5487.314085739283;5534.695591742453;5580.637258578179;13329.666758331023;13397.86602133976;13404.597862064154;13567.660808479768;13587.184768913898;2173.7608863025052;2199.5051113499494;2404.6873906392057;2480.702315722107;2626.3302857771337;9934;10012.39925604466;10014.49927503622;10404.531796069195;10454.686359409154;1835.2292037344348;1883.9058047097728;1912.2064343297516;1942.2036964844488;1943;111309;117043;125970;127078;129924;10008.848982366975;10584.682459526226;11249.10007199422;11491.655250342503;11649.301041937511;14221.85778142226;14325.212113333866;14653.853461465462;14664.633384165269;14681.119132851849;8406.83186336282;8591.05498395176;8633;8725.083866194085;8744.213020828156;8549.529775862264;8550.572471376407;8574.82850343002;8767.780805479786;8772.166644168794;4459.23527413006;4538.818447262139;4543.977280113579;4562.726236425825;4634.652401069933;1485.9895271215462;1705.763321591836;1850.5651171974575;1855.3784482198614;1878.1548303263587;865.5628907401848;865.6104752861238;893.5710858787818;954.8758661373977;981.6613268422383;19669.40991770249;20235.392938211877;20940.267090652058;21797.237096701858;21962.780372196394;889.9644014239358;911.4394647292;947.209080417845;958.7459323279337;1000.5897581991348;10937.234393592373;11192.10463162945;11264.887351126548;11283.717907052225;11289.887101129048;529230;587504;613971;643263;650331;87485;131626;133243.01219335265;143401;149138;891.9955400222957;1004.7488127968008;1019.5208252121491;1020.7295066807451;1023.5138309303021;18515.90742046335;19199.136038878565;19747.506312342306;19883.204671812964;19886.204551817766;53094.203586947;55324.44675553193;55461;56917.577060573814;57321.14018289646;81287.5935620318;81368.59315703383;84621;85029.14970850213;85881;7553.622318884144;7613.238676132342;8136.105028446747;8349.624266908126;8441.029281632691;11574.305541667527;13109.344532773513;13143.474261029452;13149.802752958905;13444.596662100153;9455.621775128919;11380.601678941197;11429.257098288585;11608.6517404478;11743.119266055252;11167.218294719292;11308.830367544659;11396.259243149168;11405.543778248777;11598.07215422781;11428.314301141958;11458.140639452242;11569.710757231136;11779.469923853276;11885.881141188478;7894.486858354188;8024.799380015546;8368;8439.746807595537;8448.028476725256;8875.600597972978;11326.660200194008;11361.204715669825;11635.301881887113;11742.647720568397 02:21:24 INFO - PROCESS | 1665 | |3;mootools.html;1518.3319339490627;1543.3595058050907;1715.236719659751;1819.581496255862;1859.7117446795735;8135.75592732219;8400.243978041975;8689.695860644879;9217.815643687121;9222.677206297772;8270.710525131622;8721.12788721129;8954.955225223881;8965.506897120657;9118.17936385725;2417.516496700658;2446.4862378900452;2450.8284420090513;2452.3746444656585;2462.162864626027;2146.3131797824703;2413.0589070262613;2433.1848830641757;2450.2036838027625;2454.8158888083376;1975.6740137877232;2192.6272533669317;2423.6485709572103;2426;2437.025189924027;2398.9640155397683;2401.771831675988;2409.987950060256;2415.5651982643203;2423.6364545318165;2392.174699728591;2403.447207142367;2410.6745589345387;2410.9517809643885;2418.733939266679;8889.022207557164;9109.407888487227;9112.7266182014;9121.087891210893;9133.269338452908;5298.417174110845;5448.019356515825;5456.427075157131;5459.317585301837;5462.890742185174;3190.9202269943203;3583.036224318934;3687.1703866630064;3736.9260060666593;3759.755615884986;1086.299336927685;1113.693734223087;1117.8938000889902;1135.7785231879786;1143.9485223164895;12101.818472722916;12110.697232569168;12137.514499420013;12143.514259429701;12148.635540933787;4707.8587642370785;4742.81569765163;4788.7366194859615;4900.828471003498;4932.161532539477;10169.288149829588;10170.288079834489;10170.898291017143;10181.490925453698;10186.337888037255;5425.213344065089;5436.592255580847;5438.755256013489;5439.3200849893765;5449.673019618756;4777.092352453023;4914.36113305268;4969.204927211629;4970.254461830755;4989.650724449254;3846.3461211594094;3850.3454412749898;3905.750159948789;3935.9016024599614;3940.802959851996;1105.8333458201514;1120.7478317378525;1197.7185361440054;1210.594450858972;1211.5396149463324;690.7099018412279;874.728834061443;877.140402405646;911.8039621481413;912.2929729459589;5656.43435656431;5829.47534721877;5850.151727999416;5945.940540594625;5947.1376650385455;475.7549861821165;479.9736014519235;487.84145152825477;488.50172823719606;635.7475772727719;3827;3998.4002399640285;4009.3384591542654;4031.4154447604933;4134.462519872457;10645.946770266253;11185.776284474428;11193.608223712132;11207.38359390225;11213.215074944676;11138.108951283877;11144.888551114547;11153.776924461628;11168.944155279334;11188.440577971069;7871.685132594746;8331.95834020838;8355.289800366916;8382.491151592772;8417.915820841836;5927.140564618193;5982.252218472691;6081.300650425258;6181.289151747606;6197.101420294122;9646.614135434786;10084.445355505517;10309.896901030894;10402.58389664405;10424.113950314006;10397.012283833024;10454.950758915596;10526.78946421052;10631.893681063091;10672.946635266773;7529.623518823927;7612.961935190288;7716.498427602188;7722.266384693445;7740.3420709240345;8231.835363292821;8284.710035148983;8371;8376.32989360862;8379.916200838157;7550.66022028999;7564.697412103675;7604.771856844303;7645.388368930361;7714.537127772352;7449.851002980018;7530.246975302426;7538.924610754042;7557.35762460197;7584.355329797029;7036.648167591702;7143.535670181422;7147;7156.248593897566;7171.713131474891;4462.866114016585;4876.658633895593;4877.463479017376;5101.336826212569;5281.524662780368;4347.282698354863;5049.293098966221;5164;5214.634975551675;5218.634695571273 02:21:24 INFO - PROCESS | 1665 | |4;prototype.html;276.8435833753929;302.1524623431275;307.77686177521315;312.25371362443764;322.0531636987256;4436.6228870545965;5241;5327.307450031495;5390.164524498704;5399.78400863965;4609.79255933483;5137.691738495693;5217.087009773293;5246.973765131169;5298.284731561238;4103.363978583309;4114.769905624085;4131.958680413202;4132.2355364257555;4134.607212314832;3822.9426558601645;4121.587841215869;4133.359329303963;4149.273877071516;4158.875233742978;3888.9222215555674;4059.817308221137;4068.7558746475156;4093.7543747375253;4137.77242251676;4070.3894415837713;4086.978255436141;4091.8363265469347;4097.713160078795;4101.343784994387;3576.123849656825;3583.1937813991904;3590.281943611288;3596.1549035976523;3601.1897323102353;4870.902581948377;5105.719185444799;5151.150060240056;5155.61332900034;5263.736813159327;3902.2585708715255;4022.597740225983;4459.7958551190995;4693.24908014716;4719.764011799396;4859.910238597402;5421.051316019721;5583.8604034899045;5595.832125036255;5609.046462101453;3010.698930106994;3748.2878253131817;3820.3887378019663;3843.2121415110114;3924.841337264522;5133.974330128325;5873.236479257712;5874.3244526879525;5878.854812675198;5906.350301466835;3905.7656540607654;3906.7655940643654;3912.1808359113147;3925.4896863408144;3940.349842275992;3814.6566808987322;3940;3964.365701487748;3969;3988.4017397390626;4440.844570440019;4570.623275896582;4611.2852507861335;4618.8452886778305;4631.606313463326;4482.529334419839;4741.810327586927;5638.351589567253;5677.489025987681;5733.305346487145;1077.0790973717515;1149.4999675141341;1249.6875781054737;1300.8373953255843;1328.2429015461287;752.9736459223901;900.9324300677475;912.625823412411;916.7249825052457;917.5870858113875;5294.205869119663;5296.384602696137;5306.681599104066;5313.893722125613;5336.839894803162;5590.645612632469;5774.007967251292;5777.364489906191;5831.300243970751;5928.970355148283;4671.556202160789;4841.9031619367415;5355.196720491957;5433.972830135824;5443.564514838803;2829.0522674903727;2912.228259511231;3026.470367685646;3044.893428729984;3070.53941908711;5344.35867695879;5377.7580008899695;5678.517326027251;6047.879042419127;6103.6032657877095;5569.777208911598;5638.887222255532;6041.516678665696;6056.728726727477;6063.7574497020505;4563.383943167696;5017.673851199734;5161.045206636634;5306.310179676694;5361.544268737201;5799.681017544076;5827.79602713903;5863.2670916135485;5877.678317064821;5879.617824841372;4643.466001409881;5535.778568857361;5553.805931724699;5793.595657802133;5854.795082172103;5431.592630552804;5613.635113717595;5790.7973220937065;6048.639056212317;6094.451499365078;3460.152262695555;3605.549306336708;4046.8178931947546;4082.897927551835;4094.426780250708;5806.300070467253;5814.244148260699;5844.766209351578;5851;5866.794662186803;4206.181858155104;4528.569785870337;5389.595780316414;5425.403205647297;5623.437656234508;4368.492869959859;4954.727489988085;5552.028395030934;5608.523275521463;5630.4369563043365;4418.469783625986;4602.930956035595;4951.752412379295;5409.377921539073;5539.556835453073;5105.948940510547;5650.3219613646625;5652.745626446737;5660.264165658438;5701.066264277635;4887.951120488749;5203.27154198405;5347.812826551052;5525.093842624288;5586.692731899784 02:21:24 INFO - PROCESS | 1665 | |5;yui.html;721.898934149219;764.575660508418;784.6978913118447;798.873588240581;839.9496030238184;15298.388064477422;15962;16622.83377166228;16732.749008764862;16787.580310492212;14827.406903723864;15024.849751502481;15067.342592314837;15080.396784128649;15082.396704131848;668.455209004662;833.5790425834945;857.5755001274347;861.4658911474894;863.8315528471951;679.5888487465087;685.1230425055911;685.8731134740065;686.3719696477717;687.1547995964966;870.5168631409565;899.1233547291404;900.4597241654988;909.7225346269386;912.3750231091724;897.4391005621486;898.1647068226547;899.1952202778509;900.3292547052422;902.1790170944474;521.1869483605587;663.4062514049898;664.4983037806473;664.6543797225464;666.0375757031092;11923.642290731292;12530.874691253153;15160.620984475367;15253.38986440541;15605.14171720555;14617.12297262157;14961.850381496155;15033;15051.247437628184;15307.31117099722;11265.168952677372;11806.645800625995;11825.586104486387;12100.334481603508;12176.147669663127;3887.961120388788;3902.5316961964745;3907.98046009771;4036.4550785643855;4051.4327994080854;110666.29478738176;112677;113021;113110.30334544988;115247.69504609861;10860.61987830438;11254.43727813606;11428.885711142948;11519.827202591969;11566.363849988164;23299;23674.64488032681;23881.04475820948;24334.26997190087;24405.26784196477;8000.8799868002025;8065.475744076616;8129;8293.253607175384;8395.958020209982;4220.451341325608;4379.934300985487;4487.371767952489;4514.052049069732;4527.7736113194205;3689.1883785567134;3794.127350709297;3795.886123416302;3800.4489349044234;3809.4285857121654;673.6160388578561;674.8852695041854;675.787127054976;683.6513378177166;689.1351354050735;591.5651995783096;614.2506142506136;632.6868200240818;650.9010570950227;701.4388489208612;7936.682532698743;9482.241420686329;9484.430934143973;9580.616775329048;9600.567974441166;597.9820605381846;659.9307072757388;672.4821887146869;675.7938828657209;679.5481005131631;4449.955500444954;4651.488336283006;4710.528947105262;4715.599174070242;4768.165571025057;159321.2033939823;161942;166539;167277.16361418116;171141;140239.29880350738;140850.88723669155;142509;143740;145336.27331863483;118255.58316377;122216.38891805484;124446;126953;128134;8084.312833409226;8652.697155599524;8677.262432693291;9044;9056.909430905871;58800.11799822921;67849;68184.65907670629;68544.31455685379;69501;94910;97014.54478182692;99870.00129998606;99894;100083;12173.69565760863;12873.291968941423;12874.935625321814;12906.161099528501;13352.332383380986;13856.930715346762;14060;14410.639734006734;14575.416983320549;15811.683766324839;13504.324783760969;13544.187348759106;14362.856371436152;14368.712625747636;14707.55877323682;11554.595589154676;13800;14040.508582199574;14058.789118163031;14588.927055364655;13422.463101476222;13461.326933653474;13548.25484598317;13931;14006.929965350108;11101.333919964827;11105;11185.66443006711;11857.644270671894;11968.940155299517;10037.5483103262;11573.18987670855;11632.429622000922;11678.599206269892;11680.47437865315 02:21:24 INFO - PROCESS | 1665 | __end_tp_report 02:21:24 INFO - PROCESS | 1665 | __start_cc_report 02:21:24 INFO - PROCESS | 1665 | _x_x_mozilla_cycle_collect,1308 02:21:24 INFO - PROCESS | 1665 | __end_cc_report 02:21:24 INFO - PROCESS | 1665 | __startTimestamp1474622484421__endTimestamp 02:21:24 INFO - PROCESS | 1665 | 02:21:24 INFO - PROCESS | 1665 | ------- Summary: start ------- 02:21:24 INFO - PROCESS | 1665 | Number of tests: 6 02:21:24 INFO - PROCESS | 1665 | 02:21:24 INFO - PROCESS | 1665 | [#0] dojo.html Cycles:165 Average:5770.06 Median:5971.73 stddev:654.54 (11.0%) stddev-sans-first:617.44 02:21:24 INFO - PROCESS | 1665 | Values: 2929.3 3308.2 3327.2 3343.2 3368.2 5622.0 5758.9 5777.2 5792.1 5799.7 5635.6 5679.5 5807.7 5818.0 5827.0 5245.0 5278.8 5289.6 5293.8 5338.8 5206.8 5223.9 5345.6 5359.7 5396.7 5262.7 5315.7 5322.9 5323.3 5327.2 5208.6 5242.1 5278.2 5290.2 5312.8 4643.0 5093.7 5225.8 5287.3 5293.9 5777.3 5809.6 5918.1 5918.9 5977.3 5178.4 5185.1 6117.5 6138.1 6139.3 6251.0 6280.7 6302.9 6304.7 6329.1 5835.5 5849.2 5859.2 5869.2 5910.0 6214.3 6218.3 6253.9 6270.7 6288.2 6203.2 6210.9 6222.5 6230.2 6239.6 6164.0 6290.7 6312.1 6325.5 6326.1 6097.7 6108.1 6131.4 6305.1 6320.7 6175.5 6196.4 6243.2 6315.9 6319.7 4983.9 4995.2 5001.1 5003.9 5010.7 4370.6 4388.4 4482.7 4485.6 4496.7 5708.4 5755.7 5762.1 5795.2 5875.9 6249.4 6274.3 6295.6 6303.4 6309.5 5799.5 5799.7 5822.4 5828.2 5858.4 5285.9 5303.0 5356.4 5356.9 5399.9 6322.3 6322.6 6330.8 6331.8 6340.6 6261.3 6305.0 6308.4 6314.8 6315.8 6188.6 6214.3 6257.8 6284.3 6322.7 6133.4 6229.8 6269.5 6274.6 6279.4 6313.4 6316.9 6325.6 6328.1 6339.9 5959.8 5990.9 6087.1 6168.2 6172.6 6082.6 6099.5 6119.1 6171.8 6207.5 5782.6 6037.5 6047.1 6047.7 6050.9 5971.7 6079.5 6153.6 6158.1 6171.2 5875.9 5923.1 5947.9 5961.9 6066.1 02:21:24 INFO - PROCESS | 1665 | 02:21:24 INFO - PROCESS | 1665 | [#1] ext.html Cycles:180 Average:81140.20 Median:20238.57 stddev:198510.54 (980.9%) stddev-sans-first:198974.95 02:21:24 INFO - PROCESS | 1665 | Values: 442.6 474.9 503.5 524.4 525.6 30752.8 40900.6 42298.0 42403.4 42628.8 42386.7 43631.0 43907.3 44032.0 44058.8 8801.3 8938.0 10064.4 10076.2 10095.8 8767.3 8978.9 9904.9 11870.5 12192.2 12149.0 12155.5 12168.6 12171.3 12207.9 12268.9 12322.5 12342.8 12360.2 12373.3 11910.5 11977.8 11997.7 12006.6 12016.5 40990.6 41282.4 41334.6 41361.8 41369.6 3504.9 3574.3 3978.7 4017.4 4074.1 29733.7 29780.6 29787.0 31771.0 31775.8 3217.8 3294.8 3326.6 3435.9 3441.6 497207.0 503761.0 504689.0 506439.0 506530.5 33433.3 33944.7 33993.3 35183.6 60132.8 35446.6 35536.3 35552.5 35587.5 35608.0 14735.3 14954.0 14963.0 14988.8 15042.4 11482.3 12643.6 12735.7 12741.4 12744.6 7198.5 7335.2 7347.4 7350.7 7359.1 3171.8 3207.0 3208.3 3248.2 3256.4 965.1 972.9 976.2 1054.7 1107.9 28828.4 29730.6 30108.8 30808.0 30815.6 835.8 949.3 956.7 1126.3 1231.8 14734.0 15863.9 16207.8 16256.0 16297.9 703389.0 712473.0 713851.0 715174.0 715905.8 49730.0 50544.7 57892.8 58373.4 58800.0 1372.7 1381.1 1409.7 1419.1 1420.2 29884.3 31115.7 31387.7 31457.1 32268.7 50748.0 51261.5 51266.7 51458.7 51486.7 900207.0 930071.0 931448.0 934874.0 936787.0 40584.0 40935.6 41224.4 41338.0 42287.8 45870.0 45949.1 46071.1 46664.0 46904.8 36902.8 37790.4 38758.6 39806.4 39998.4 37686.4 38279.6 38622.8 39554.8 39695.8 37335.4 37860.2 38017.4 38093.8 38161.8 29547.4 31366.4 33399.8 34145.8 34162.0 21726.5 22947.0 24519.5 25163.7 25775.5 02:21:24 INFO - PROCESS | 1665 | 02:21:24 INFO - PROCESS | 1665 | [#2] jquery.html Cycles:180 Average:35263.53 Median:21880.01 stddev:101484.64 (463.8%) stddev-sans-first:101735.48 02:21:24 INFO - PROCESS | 1665 | Values: 353.5 374.7 375.1 387.3 406.0 15343.4 15420.1 17373.3 20370.6 20826.6 20030.7 21043.8 21128.3 21260.5 21520.4 4911.7 5810.1 5905.5 6167.3 6170.3 5954.3 6132.1 6133.5 6134.7 6156.8 5796.4 5982.0 6035.2 6082.7 6091.0 5909.0 5954.5 5960.7 5964.1 5964.3 5198.7 5232.3 5487.3 5534.7 5580.6 13329.7 13397.9 13404.6 13567.7 13587.2 2173.8 2199.5 2404.7 2480.7 2626.3 9934.0 10012.4 10014.5 10404.5 10454.7 1835.2 1883.9 1912.2 1942.2 1943.0 111309.0 117043.0 125970.0 127078.0 129924.0 10008.8 10584.7 11249.1 11491.7 11649.3 14221.9 14325.2 14653.9 14664.6 14681.1 8406.8 8591.1 8633.0 8725.1 8744.2 8549.5 8550.6 8574.8 8767.8 8772.2 4459.2 4538.8 4544.0 4562.7 4634.7 1486.0 1705.8 1850.6 1855.4 1878.2 865.6 865.6 893.6 954.9 981.7 19669.4 20235.4 20940.3 21797.2 21962.8 890.0 911.4 947.2 958.7 1000.6 10937.2 11192.1 11264.9 11283.7 11289.9 529230.0 587504.0 613971.0 643263.0 650331.0 87485.0 131626.0 133243.0 143401.0 149138.0 892.0 1004.7 1019.5 1020.7 1023.5 18515.9 19199.1 19747.5 19883.2 19886.2 53094.2 55324.4 55461.0 56917.6 57321.1 81287.6 81368.6 84621.0 85029.1 85881.0 7553.6 7613.2 8136.1 8349.6 8441.0 11574.3 13109.3 13143.5 13149.8 13444.6 9455.6 11380.6 11429.3 11608.7 11743.1 11167.2 11308.8 11396.3 11405.5 11598.1 11428.3 11458.1 11569.7 11779.5 11885.9 7894.5 8024.8 8368.0 8439.7 8448.0 8875.6 11326.7 11361.2 11635.3 11742.6 02:21:24 INFO - PROCESS | 1665 | 02:21:24 INFO - PROCESS | 1665 | [#3] mootools.html Cycles:180 Average:5822.97 Median:2634.36 stddev:3329.43 (126.4%) stddev-sans-first:3323.06 02:21:24 INFO - PROCESS | 1665 | Values: 1518.3 1543.4 1715.2 1819.6 1859.7 8135.8 8400.2 8689.7 9217.8 9222.7 8270.7 8721.1 8955.0 8965.5 9118.2 2417.5 2446.5 2450.8 2452.4 2462.2 2146.3 2413.1 2433.2 2450.2 2454.8 1975.7 2192.6 2423.6 2426.0 2437.0 2399.0 2401.8 2410.0 2415.6 2423.6 2392.2 2403.4 2410.7 2411.0 2418.7 8889.0 9109.4 9112.7 9121.1 9133.3 5298.4 5448.0 5456.4 5459.3 5462.9 3190.9 3583.0 3687.2 3736.9 3759.8 1086.3 1113.7 1117.9 1135.8 1143.9 12101.8 12110.7 12137.5 12143.5 12148.6 4707.9 4742.8 4788.7 4900.8 4932.2 10169.3 10170.3 10170.9 10181.5 10186.3 5425.2 5436.6 5438.8 5439.3 5449.7 4777.1 4914.4 4969.2 4970.3 4989.7 3846.3 3850.3 3905.8 3935.9 3940.8 1105.8 1120.7 1197.7 1210.6 1211.5 690.7 874.7 877.1 911.8 912.3 5656.4 5829.5 5850.2 5945.9 5947.1 475.8 480.0 487.8 488.5 635.7 3827.0 3998.4 4009.3 4031.4 4134.5 10645.9 11185.8 11193.6 11207.4 11213.2 11138.1 11144.9 11153.8 11168.9 11188.4 7871.7 8332.0 8355.3 8382.5 8417.9 5927.1 5982.3 6081.3 6181.3 6197.1 9646.6 10084.4 10309.9 10402.6 10424.1 10397.0 10455.0 10526.8 10631.9 10672.9 7529.6 7613.0 7716.5 7722.3 7740.3 8231.8 8284.7 8371.0 8376.3 8379.9 7550.7 7564.7 7604.8 7645.4 7714.5 7449.9 7530.2 7538.9 7557.4 7584.4 7036.6 7143.5 7147.0 7156.2 7171.7 4462.9 4876.7 4877.5 5101.3 5281.5 4347.3 5049.3 5164.0 5214.6 5218.6 02:21:24 INFO - PROCESS | 1665 | 02:21:24 INFO - PROCESS | 1665 | [#4] prototype.html Cycles:180 Average:4538.03 Median:5119.96 stddev:1389.09 (27.1%) stddev-sans-first:1355.67 02:21:24 INFO - PROCESS | 1665 | Values: 276.8 302.2 307.8 312.3 322.1 4436.6 5241.0 5327.3 5390.2 5399.8 4609.8 5137.7 5217.1 5247.0 5298.3 4103.4 4114.8 4132.0 4132.2 4134.6 3822.9 4121.6 4133.4 4149.3 4158.9 3888.9 4059.8 4068.8 4093.8 4137.8 4070.4 4087.0 4091.8 4097.7 4101.3 3576.1 3583.2 3590.3 3596.2 3601.2 4870.9 5105.7 5151.2 5155.6 5263.7 3902.3 4022.6 4459.8 4693.2 4719.8 4859.9 5421.1 5583.9 5595.8 5609.0 3010.7 3748.3 3820.4 3843.2 3924.8 5134.0 5873.2 5874.3 5878.9 5906.4 3905.8 3906.8 3912.2 3925.5 3940.3 3814.7 3940.0 3964.4 3969.0 3988.4 4440.8 4570.6 4611.3 4618.8 4631.6 4482.5 4741.8 5638.4 5677.5 5733.3 1077.1 1149.5 1249.7 1300.8 1328.2 753.0 900.9 912.6 916.7 917.6 5294.2 5296.4 5306.7 5313.9 5336.8 5590.6 5774.0 5777.4 5831.3 5929.0 4671.6 4841.9 5355.2 5434.0 5443.6 2829.1 2912.2 3026.5 3044.9 3070.5 5344.4 5377.8 5678.5 6047.9 6103.6 5569.8 5638.9 6041.5 6056.7 6063.8 4563.4 5017.7 5161.0 5306.3 5361.5 5799.7 5827.8 5863.3 5877.7 5879.6 4643.5 5535.8 5553.8 5793.6 5854.8 5431.6 5613.6 5790.8 6048.6 6094.5 3460.2 3605.5 4046.8 4082.9 4094.4 5806.3 5814.2 5844.8 5851.0 5866.8 4206.2 4528.6 5389.6 5425.4 5623.4 4368.5 4954.7 5552.0 5608.5 5630.4 4418.5 4602.9 4951.8 5409.4 5539.6 5105.9 5650.3 5652.7 5660.3 5701.1 4888.0 5203.3 5347.8 5525.1 5586.7 02:21:24 INFO - PROCESS | 1665 | 02:21:24 INFO - PROCESS | 1665 | [#5] yui.html Cycles:180 Average:26618.14 Median:14047.23 stddev:43479.76 (309.5%) stddev-sans-first:43558.25 02:21:24 INFO - PROCESS | 1665 | Values: 721.9 764.6 784.7 798.9 839.9 15298.4 15962.0 16622.8 16732.7 16787.6 14827.4 15024.8 15067.3 15080.4 15082.4 668.5 833.6 857.6 861.5 863.8 679.6 685.1 685.9 686.4 687.2 870.5 899.1 900.5 909.7 912.4 897.4 898.2 899.2 900.3 902.2 521.2 663.4 664.5 664.7 666.0 11923.6 12530.9 15160.6 15253.4 15605.1 14617.1 14961.9 15033.0 15051.2 15307.3 11265.2 11806.6 11825.6 12100.3 12176.1 3888.0 3902.5 3908.0 4036.5 4051.4 110666.3 112677.0 113021.0 113110.3 115247.7 10860.6 11254.4 11428.9 11519.8 11566.4 23299.0 23674.6 23881.0 24334.3 24405.3 8000.9 8065.5 8129.0 8293.3 8396.0 4220.5 4379.9 4487.4 4514.1 4527.8 3689.2 3794.1 3795.9 3800.4 3809.4 673.6 674.9 675.8 683.7 689.1 591.6 614.3 632.7 650.9 701.4 7936.7 9482.2 9484.4 9580.6 9600.6 598.0 659.9 672.5 675.8 679.5 4450.0 4651.5 4710.5 4715.6 4768.2 159321.2 161942.0 166539.0 167277.2 171141.0 140239.3 140850.9 142509.0 143740.0 145336.3 118255.6 122216.4 124446.0 126953.0 128134.0 8084.3 8652.7 8677.3 9044.0 9056.9 58800.1 67849.0 68184.7 68544.3 69501.0 94910.0 97014.5 99870.0 99894.0 100083.0 12173.7 12873.3 12874.9 12906.2 13352.3 13856.9 14060.0 14410.6 14575.4 15811.7 13504.3 13544.2 14362.9 14368.7 14707.6 11554.6 13800.0 14040.5 14058.8 14588.9 13422.5 13461.3 13548.3 13931.0 14006.9 11101.3 11105.0 11185.7 11857.6 11968.9 10037.5 11573.2 11632.4 11678.6 11680.5 02:21:24 INFO - PROCESS | 1665 | -------- Summary: end -------- 02:21:24 INFO - PROCESS | 1665 | 02:21:25 INFO - TEST-INFO | 1665: exit 0 02:21:25 INFO - TEST-OK | dromaeo_css | took 1117369ms 02:21:25 INFO - TEST-START | kraken 02:21:25 INFO - operating with platform_type : mac_ 02:21:25 INFO - Initialising browser for kraken test... 02:21:25 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/tmp9qARo_/profile http://localhost:49272/getInfo.html) 02:21:27 INFO - PROCESS | 1671 | __metrics Screen width/height:1600/1200 02:21:27 INFO - PROCESS | 1671 | colorDepth:24 02:21:27 INFO - PROCESS | 1671 | Browser inner width/height: 1024/689 02:21:27 INFO - PROCESS | 1671 | __metrics 02:21:27 INFO - PROCESS | 1671 | 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" 02:21:27 INFO - PROCESS | 1671 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:21:28 INFO - TEST-INFO | 1671: exit 0 02:21:28 INFO - Browser initialized. 02:21:28 INFO - Running cycle 1/1 for kraken test... 02:21:28 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/tmp9qARo_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:21:40 INFO - PROCESS | 1673 | RSS: Main: 239050752 02:21:40 INFO - PROCESS | 1673 | 02:21:42 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection) 02:21:43 INFO - PROCESS | 1673 | RSS: Main: 286437376 02:21:43 INFO - PROCESS | 1673 | 02:21:46 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-dft) 02:21:47 INFO - PROCESS | 1673 | RSS: Main: 296714240 02:21:47 INFO - PROCESS | 1673 | 02:21:50 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-fft) 02:21:50 INFO - PROCESS | 1673 | RSS: Main: 390492160 02:21:50 INFO - PROCESS | 1673 | 02:21:53 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator) 02:21:53 INFO - PROCESS | 1673 | RSS: Main: 293097472 02:21:53 INFO - PROCESS | 1673 | 02:21:55 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:21:56 INFO - PROCESS | 1673 | RSS: Main: 293957632 02:21:56 INFO - PROCESS | 1673 | 02:21:58 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom) 02:21:59 INFO - PROCESS | 1673 | RSS: Main: 330637312 02:21:59 INFO - PROCESS | 1673 | 02:22:02 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate) 02:22:03 INFO - PROCESS | 1673 | RSS: Main: 332247040 02:22:03 INFO - PROCESS | 1673 | 02:22:05 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial) 02:22:06 INFO - PROCESS | 1673 | RSS: Main: 329875456 02:22:06 INFO - PROCESS | 1673 | 02:22:08 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:22:08 INFO - PROCESS | 1673 | RSS: Main: 306749440 02:22:08 INFO - PROCESS | 1673 | 02:22:10 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:22:11 INFO - PROCESS | 1673 | RSS: Main: 310231040 02:22:11 INFO - PROCESS | 1673 | 02:22:13 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:22:14 INFO - PROCESS | 1673 | RSS: Main: 308092928 02:22:14 INFO - PROCESS | 1673 | 02:22:16 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:22:17 INFO - PROCESS | 1673 | RSS: Main: 324505600 02:22:17 INFO - PROCESS | 1673 | 02:22:20 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:22:21 INFO - PROCESS | 1673 | RSS: Main: 320618496 02:22:21 INFO - PROCESS | 1673 | 02:22:22 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49272/tests/kraken/driver.html?testName=ai-astar) 02:22:23 INFO - PROCESS | 1673 | RSS: Main: 363765760 02:22:23 INFO - PROCESS | 1673 | 02:22:23 INFO - PROCESS | 1673 | __start_tp_report 02:22:23 INFO - PROCESS | 1673 | _x_x_mozilla_page_load 02:22:23 INFO - PROCESS | 1673 | _x_x_mozilla_page_load_details 02:22:23 INFO - PROCESS | 1673 | |i|pagename|runs| 02:22:23 INFO - PROCESS | 1673 | |0;ai-astar;114;112;113;113;112;114;113;113;113;114 02:22:23 INFO - PROCESS | 1673 | |1;audio-beat-detection;160;136;107;168;134;109;108;108;138;109 02:22:23 INFO - PROCESS | 1673 | |2;audio-dft;186;186;181;186;184;182;183;182;182;181 02:22:23 INFO - PROCESS | 1673 | |3;audio-fft;81;56;61;107;85;81;50;74;100;78 02:22:23 INFO - PROCESS | 1673 | |4;audio-oscillator;87;72;93;69;68;68;92;67;68;92 02:22:23 INFO - PROCESS | 1673 | |5;imaging-gaussian-blur;88;87;88;86;88;85;90;86;89;85 02:22:23 INFO - PROCESS | 1673 | |6;imaging-darkroom;94;94;95;95;94;97;95;89;131;146 02:22:23 INFO - PROCESS | 1673 | |7;imaging-desaturate;85;84;87;86;84;93;84;86;86;87 02:22:23 INFO - PROCESS | 1673 | |8;json-parse-financial;52;51;52;51;56;56;57;55;55;55 02:22:23 INFO - PROCESS | 1673 | |9;json-stringify-tinderbox;65;75;77;73;76;70;68;70;70;70 02:22:23 INFO - PROCESS | 1673 | |10;stanford-crypto-aes;82;81;80;91;99;98;76;79;81;82 02:22:23 INFO - PROCESS | 1673 | |11;stanford-crypto-ccm;142;148;144;146;136;139;137;133;178;158 02:22:23 INFO - PROCESS | 1673 | |12;stanford-crypto-pbkdf2;160;161;161;160;156;163;161;159;217;182 02:22:23 INFO - PROCESS | 1673 | |13;stanford-crypto-sha256-iterative;66;66;67;67;67;66;68;65;66;65 02:22:23 INFO - PROCESS | 1673 | __end_tp_report 02:22:23 INFO - PROCESS | 1673 | __start_cc_report 02:22:23 INFO - PROCESS | 1673 | _x_x_mozilla_cycle_collect,2009 02:22:23 INFO - PROCESS | 1673 | __end_cc_report 02:22:23 INFO - PROCESS | 1673 | __startTimestamp1474622543021__endTimestamp 02:22:23 INFO - PROCESS | 1673 | 02:22:23 INFO - PROCESS | 1673 | ------- Summary: start ------- 02:22:23 INFO - PROCESS | 1673 | Number of tests: 14 02:22:23 INFO - PROCESS | 1673 | 02:22:23 INFO - PROCESS | 1673 | [#0] ai-astar Cycles:10 Average:113.10 Median:113.00 stddev:0.74 (0.7%) stddev-sans-first:0.71 02:22:23 INFO - PROCESS | 1673 | Values: 114.0 112.0 113.0 113.0 112.0 114.0 113.0 113.0 113.0 114.0 02:22:23 INFO - PROCESS | 1673 | 02:22:23 INFO - PROCESS | 1673 | [#1] audio-beat-detection Cycles:10 Average:127.70 Median:135.00 stddev:23.06 (17.1%) stddev-sans-first:21.29 02:22:23 INFO - PROCESS | 1673 | Values: 160.0 136.0 107.0 168.0 134.0 109.0 108.0 108.0 138.0 109.0 02:22:23 INFO - PROCESS | 1673 | 02:22:23 INFO - PROCESS | 1673 | [#2] audio-dft Cycles:10 Average:183.30 Median:183.50 stddev:2.06 (1.1%) stddev-sans-first:1.94 02:22:23 INFO - PROCESS | 1673 | Values: 186.0 186.0 181.0 186.0 184.0 182.0 183.0 182.0 182.0 181.0 02:22:23 INFO - PROCESS | 1673 | 02:22:23 INFO - PROCESS | 1673 | [#3] audio-fft Cycles:10 Average:77.30 Median:76.00 stddev:18.14 (23.9%) stddev-sans-first:19.19 02:22:23 INFO - PROCESS | 1673 | Values: 81.0 56.0 61.0 107.0 85.0 81.0 50.0 74.0 100.0 78.0 02:22:23 INFO - PROCESS | 1673 | 02:22:23 INFO - PROCESS | 1673 | [#4] audio-oscillator Cycles:10 Average:77.60 Median:79.50 stddev:11.71 (14.7%) stddev-sans-first:11.92 02:22:23 INFO - PROCESS | 1673 | Values: 87.0 72.0 93.0 69.0 68.0 68.0 92.0 67.0 68.0 92.0 02:22:23 INFO - PROCESS | 1673 | 02:22:23 INFO - PROCESS | 1673 | [#5] imaging-gaussian-blur Cycles:10 Average:87.20 Median:88.00 stddev:1.69 (1.9%) stddev-sans-first:1.76 02:22:23 INFO - PROCESS | 1673 | Values: 88.0 87.0 88.0 86.0 88.0 85.0 90.0 86.0 89.0 85.0 02:22:23 INFO - PROCESS | 1673 | 02:22:23 INFO - PROCESS | 1673 | [#6] imaging-darkroom Cycles:10 Average:103.00 Median:94.50 stddev:19.15 (20.3%) stddev-sans-first:20.03 02:22:23 INFO - PROCESS | 1673 | Values: 94.0 94.0 95.0 95.0 94.0 97.0 95.0 89.0 131.0 146.0 02:22:23 INFO - PROCESS | 1673 | 02:22:23 INFO - PROCESS | 1673 | [#7] imaging-desaturate Cycles:10 Average:86.20 Median:86.00 stddev:2.66 (3.1%) stddev-sans-first:2.78 02:22:23 INFO - PROCESS | 1673 | Values: 85.0 84.0 87.0 86.0 84.0 93.0 84.0 86.0 86.0 87.0 02:22:23 INFO - PROCESS | 1673 | 02:22:23 INFO - PROCESS | 1673 | [#8] json-parse-financial Cycles:10 Average:54.00 Median:55.00 stddev:2.26 (4.1%) stddev-sans-first:2.28 02:22:23 INFO - PROCESS | 1673 | Values: 52.0 51.0 52.0 51.0 56.0 56.0 57.0 55.0 55.0 55.0 02:22:23 INFO - PROCESS | 1673 | 02:22:23 INFO - PROCESS | 1673 | [#9] json-stringify-tinderbox Cycles:10 Average:71.40 Median:71.50 stddev:3.78 (5.3%) stddev-sans-first:3.22 02:22:23 INFO - PROCESS | 1673 | Values: 65.0 75.0 77.0 73.0 76.0 70.0 68.0 70.0 70.0 70.0 02:22:23 INFO - PROCESS | 1673 | 02:22:23 INFO - PROCESS | 1673 | [#10] stanford-crypto-aes Cycles:10 Average:84.90 Median:82.00 stddev:8.12 (9.9%) stddev-sans-first:8.54 02:22:23 INFO - PROCESS | 1673 | Values: 82.0 81.0 80.0 91.0 99.0 98.0 76.0 79.0 81.0 82.0 02:22:23 INFO - PROCESS | 1673 | 02:22:23 INFO - PROCESS | 1673 | [#11] stanford-crypto-ccm Cycles:10 Average:146.10 Median:145.00 stddev:13.30 (9.2%) stddev-sans-first:14.02 02:22:23 INFO - PROCESS | 1673 | Values: 142.0 148.0 144.0 146.0 136.0 139.0 137.0 133.0 178.0 158.0 02:22:23 INFO - PROCESS | 1673 | 02:22:23 INFO - PROCESS | 1673 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.00 Median:161.00 stddev:18.62 (11.6%) stddev-sans-first:19.53 02:22:23 INFO - PROCESS | 1673 | Values: 160.0 161.0 161.0 160.0 156.0 163.0 161.0 159.0 217.0 182.0 02:22:23 INFO - PROCESS | 1673 | 02:22:23 INFO - PROCESS | 1673 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.30 Median:66.50 stddev:0.95 (1.4%) stddev-sans-first:1.00 02:22:23 INFO - PROCESS | 1673 | Values: 66.0 66.0 67.0 67.0 67.0 66.0 68.0 65.0 66.0 65.0 02:22:23 INFO - PROCESS | 1673 | -------- Summary: end -------- 02:22:23 INFO - PROCESS | 1673 | 02:22:23 INFO - TEST-INFO | 1673: exit 0 02:22:23 INFO - TEST-OK | kraken | took 58827ms 02:22:23 INFO - SUITE-END | took 1176s 02:22:24 INFO - Completed test suite (00:19:36) 02:22:24 INFO - javascript benchmark 02:22:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2929.3116117712334, 3308.17295676081, 3327.168207948013, 3343.1809206744365, 3368.1747971746927, 5622.044252477079, 5758.856028599282, 5777.248957635502, 5792.102224155263, 5799.681017544044, 5635.63368381056, 5679.545636349092, 5807.680577568232, 5818.0109381405155, 5826.9708651456785, 5245.0, 5278.788848446067, 5289.603279754015, 5293.841184764463, 5338.839834804962, 5206.7917283308625, 5223.947760522384, 5345.625806193568, 5359.7320133993335, 5396.730163491829, 5262.736863156846, 5315.654482458647, 5322.920156197641, 5323.307969963899, 5327.174287985349, 5208.557272631812, 5242.1088414969545, 5278.208268759717, 5290.232916227144, 5312.840614781524, 4643.048175124091, 5093.694378337312, 5225.817096401608, 5287.312649355597, 5293.947060529384, 5777.335606405233, 5809.593328467009, 5918.112283157518, 5918.881622367571, 5977.282726072899, 5178.378594568676, 5185.144451165553, 6117.541184411187, 6138.07928810682, 6139.3388173831445, 6250.9998400255745, 6280.685965701697, 6302.87394252117, 6304.716287767062, 6329.145565348711, 5835.4748072673665, 5849.239598852122, 5859.1797148399255, 5869.178315035899, 5909.970450147722, 6214.285357183891, 6218.284897236786, 6253.937460625427, 6270.6864656766975, 6288.245410550671, 6203.2245969253845, 6210.937890621126, 6222.502199824004, 6230.158928544679, 6239.563230573907, 6163.96918015416, 6290.716917738713, 6312.0531920211415, 6325.462335701517, 6326.051092336094, 6097.695115244309, 6108.129596501707, 6131.437835141539, 6305.14880491137, 6320.71556779946, 6175.505959523227, 6196.3803619638575, 6243.157173781481, 6315.936840631627, 6319.747210111636, 4983.900321993612, 4995.150824359867, 5001.149804533238, 5003.899142188713, 5010.69935803853, 4370.606645401929, 4388.363687265392, 4482.708623939434, 4485.618722408632, 4496.730196188174, 5708.372079071299, 5755.740991655385, 5762.1068734346245, 5795.1886735857015, 5875.941240587625, 6249.437550620466, 6274.341194174637, 6295.5907865988565, 6303.36966303366, 6309.526785491106, 5799.507041901401, 5799.652020878761, 5822.417758224144, 5828.184054232411, 5858.414158584193, 5285.894282114336, 5302.973485132549, 5356.4107948125675, 5356.91964620531, 5399.946000540023, 6322.304546499881, 6322.589031712924, 6330.8417289567205, 6331.841703957438, 6340.587861788969, 6261.3112557617715, 6305.0, 6308.400701933309, 6314.778982735582, 6315.842103947438, 6188.566800323934, 6214.2853571838, 6257.812265632038, 6284.340144284784, 6322.747090116344, 6133.38666133401, 6229.844253893689, 6269.49844012487, 6274.560780745304, 6279.434850863444, 6313.368663133833, 6316.936830631635, 6325.620462772248, 6328.082428047999, 6339.936600633934, 5959.821205363846, 5990.910136347871, 6087.117367981529, 6168.167297414791, 6172.598781079216, 6082.635041897501, 6099.451049405575, 6119.051547010221, 6171.814845554641, 6207.503399728102, 5782.595218334676, 6037.486813620892, 6047.0627052806885, 6047.727852246571, 6050.941085310141, 5971.731272092853, 6079.544034197364, 6153.630782152906, 6158.107074474086, 6171.228596425447, 5875.882482350415, 5923.052311630118, 5947.851303717442, 5961.850953726192, 6066.090086486885], "value": 5726.291831353105, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [442.58176023657614, 474.9382580264566, 503.514108884926, 524.4205153305597, 525.61104782461, 30752.84623576882, 40900.59099409005, 42298.0, 42403.363949540704, 42628.78685606575, 42386.72839814803, 43631.0, 43907.34138987918, 44032.0, 44058.77970610151, 8801.251893589053, 8938.0, 10064.446455444948, 10076.244281678866, 10095.798084038315, 8767.342449316295, 8978.910210897873, 9904.900950990506, 11870.46582903767, 12192.207506512093, 12149.02807775376, 12155.513779448811, 12168.627117712049, 12171.33057681827, 12207.938960305186, 12268.877311226863, 12322.507099716, 12342.75314493714, 12360.196587221802, 12373.319467429288, 11910.523579056913, 11977.760444791056, 11997.700057498545, 12006.63980080599, 12016.519339226508, 40990.59009409927, 41282.38076428856, 41334.58665413367, 41361.79319103385, 41369.58630413718, 3504.9299014019575, 3574.3208790329754, 3978.661813745835, 4017.377306517465, 4074.124063326399, 29733.702662973308, 29780.553291700642, 29786.95745648892, 31771.0, 31775.84112079448, 3217.8391080445886, 3294.769366144371, 3326.600807903043, 3435.862565497377, 3441.6214216436174, 497206.9999999964, 503761.0, 504689.0, 506439.0, 506530.4673476646, 33433.33133337319, 33944.66055339415, 33993.32013359719, 35183.64816351804, 60132.79734405287, 35446.64553354433, 35536.289274214374, 35552.466712999325, 35587.4661880072, 35608.0, 14735.263236838115, 14954.0, 14963.027403218755, 14988.775168372484, 15042.398304067934, 11482.253653512495, 12643.557475488315, 12735.745285094246, 12741.426635801412, 12744.61766147017, 7198.49610527258, 7335.229800870939, 7347.37547308474, 7350.7427240046345, 7359.1169059713175, 3171.8255495947483, 3206.9839650801596, 3208.3102133041507, 3248.2366643838677, 3256.4301247281633, 965.0735294117585, 972.9416235025922, 976.1848856205148, 1054.651964851597, 1107.8818590555647, 28828.423431531253, 29730.55404168896, 30108.84945575258, 30808.0, 30815.610282869315, 835.7994081420537, 949.3354651743807, 956.7368973532334, 1126.267925848189, 1231.815227715832, 14734.042287251294, 15863.920680396755, 16207.837921620869, 16256.0, 16297.91851040761, 703389.0, 712473.0, 713851.0, 715174.0, 715905.8409415943, 49730.0, 50544.747276263384, 57892.8421431569, 58373.416265837644, 58800.0, 1372.670559065817, 1381.1436909116212, 1409.7251036047871, 1419.1343280598826, 1420.2259768426231, 29884.252893677833, 31115.68884311128, 31387.686123138476, 31457.05628831139, 32268.677313226566, 50747.985040299725, 51261.48738512716, 51266.74366628143, 51458.742706286226, 51486.74256628843, 900207.0, 930071.0, 931448.0, 934874.0, 936787.0, 40584.0, 40935.59064409318, 41224.38163427611, 41338.0, 42287.788561057, 45870.0, 45949.09432698124, 46071.07857842757, 46664.0, 46904.765476172404, 36902.8154859224, 37790.43314350342, 38758.61241387663, 39806.40290395589, 39998.40002399908, 37686.434703480016, 38279.617203827605, 38622.841314760604, 39554.802225988686, 39695.80152099221, 37335.43996840104, 37860.24279514449, 38017.429738553394, 38093.80953095217, 38161.80919095387, 29547.409051818413, 31366.372672545964, 33399.81305701784, 34145.82927085448, 34162.0, 21726.45683857916, 22947.0, 24519.509609807348, 25163.74836251614, 25775.484490310464], "value": 19471.237728694276, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.48391348631, 374.7189607794154, 375.0941476334652, 387.27579426472494, 405.98173082211315, 15343.38626454942, 15420.074795512262, 17373.30506779729, 20370.59258814823, 20826.630121750157, 20030.69953950692, 21043.78956210441, 21128.260510882123, 21260.468488287763, 21520.354389368345, 4911.729854857981, 5810.099434587624, 5905.468507834294, 6167.321594624587, 6170.259568851721, 5954.255718035246, 6132.110843927628, 6133.478654314388, 6134.662593557375, 6156.84607884802, 5796.391378905218, 5982.042873140298, 6035.155078289043, 6082.695865206744, 6090.969545152268, 5909.025010873201, 5954.4938680212235, 5960.672163031031, 5964.135200395962, 5964.314103878066, 5198.688078715251, 5232.293640358541, 5487.314085739283, 5534.695591742453, 5580.637258578179, 13329.666758331023, 13397.86602133976, 13404.597862064154, 13567.660808479768, 13587.184768913898, 2173.7608863025052, 2199.5051113499494, 2404.6873906392057, 2480.702315722107, 2626.3302857771337, 9934.0, 10012.39925604466, 10014.49927503622, 10404.531796069195, 10454.686359409154, 1835.2292037344348, 1883.9058047097728, 1912.2064343297516, 1942.2036964844488, 1943.0, 111309.0, 117043.0, 125970.0, 127078.0, 129924.0, 10008.848982366975, 10584.682459526226, 11249.10007199422, 11491.655250342503, 11649.301041937511, 14221.85778142226, 14325.212113333866, 14653.853461465462, 14664.633384165269, 14681.119132851849, 8406.83186336282, 8591.05498395176, 8633.0, 8725.083866194085, 8744.213020828156, 8549.529775862264, 8550.572471376407, 8574.82850343002, 8767.780805479786, 8772.166644168794, 4459.23527413006, 4538.818447262139, 4543.977280113579, 4562.726236425825, 4634.652401069933, 1485.9895271215462, 1705.763321591836, 1850.5651171974575, 1855.3784482198614, 1878.1548303263587, 865.5628907401848, 865.6104752861238, 893.5710858787818, 954.8758661373977, 981.6613268422383, 19669.40991770249, 20235.392938211877, 20940.267090652058, 21797.237096701858, 21962.780372196394, 889.9644014239358, 911.4394647292, 947.209080417845, 958.7459323279337, 1000.5897581991348, 10937.234393592373, 11192.10463162945, 11264.887351126548, 11283.717907052225, 11289.887101129048, 529230.0, 587504.0, 613971.0, 643263.0, 650331.0, 87485.0, 131626.0, 133243.01219335265, 143401.0, 149138.0, 891.9955400222957, 1004.7488127968008, 1019.5208252121491, 1020.7295066807451, 1023.5138309303021, 18515.90742046335, 19199.136038878565, 19747.506312342306, 19883.204671812964, 19886.204551817766, 53094.203586947, 55324.44675553193, 55461.0, 56917.577060573814, 57321.14018289646, 81287.5935620318, 81368.59315703383, 84621.0, 85029.14970850213, 85881.0, 7553.622318884144, 7613.238676132342, 8136.105028446747, 8349.624266908126, 8441.029281632691, 11574.305541667527, 13109.344532773513, 13143.474261029452, 13149.802752958905, 13444.596662100153, 9455.621775128919, 11380.601678941197, 11429.257098288585, 11608.6517404478, 11743.119266055252, 11167.218294719292, 11308.830367544659, 11396.259243149168, 11405.543778248777, 11598.07215422781, 11428.314301141958, 11458.140639452242, 11569.710757231136, 11779.469923853276, 11885.881141188478, 7894.486858354188, 8024.799380015546, 8368.0, 8439.746807595537, 8448.028476725256, 8875.600597972978, 11326.660200194008, 11361.204715669825, 11635.301881887113, 11742.647720568397], "value": 9460.484657908066, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1518.3319339490627, 1543.3595058050907, 1715.236719659751, 1819.581496255862, 1859.7117446795735, 8135.75592732219, 8400.243978041975, 8689.695860644879, 9217.815643687121, 9222.677206297772, 8270.710525131622, 8721.12788721129, 8954.955225223881, 8965.506897120657, 9118.17936385725, 2417.516496700658, 2446.4862378900452, 2450.8284420090513, 2452.3746444656585, 2462.162864626027, 2146.3131797824703, 2413.0589070262613, 2433.1848830641757, 2450.2036838027625, 2454.8158888083376, 1975.6740137877232, 2192.6272533669317, 2423.6485709572103, 2426.0, 2437.025189924027, 2398.9640155397683, 2401.771831675988, 2409.987950060256, 2415.5651982643203, 2423.6364545318165, 2392.174699728591, 2403.447207142367, 2410.6745589345387, 2410.9517809643885, 2418.733939266679, 8889.022207557164, 9109.407888487227, 9112.7266182014, 9121.087891210893, 9133.269338452908, 5298.417174110845, 5448.019356515825, 5456.427075157131, 5459.317585301837, 5462.890742185174, 3190.9202269943203, 3583.036224318934, 3687.1703866630064, 3736.9260060666593, 3759.755615884986, 1086.299336927685, 1113.693734223087, 1117.8938000889902, 1135.7785231879786, 1143.9485223164895, 12101.818472722916, 12110.697232569168, 12137.514499420013, 12143.514259429701, 12148.635540933787, 4707.8587642370785, 4742.81569765163, 4788.7366194859615, 4900.828471003498, 4932.161532539477, 10169.288149829588, 10170.288079834489, 10170.898291017143, 10181.490925453698, 10186.337888037255, 5425.213344065089, 5436.592255580847, 5438.755256013489, 5439.3200849893765, 5449.673019618756, 4777.092352453023, 4914.36113305268, 4969.204927211629, 4970.254461830755, 4989.650724449254, 3846.3461211594094, 3850.3454412749898, 3905.750159948789, 3935.9016024599614, 3940.802959851996, 1105.8333458201514, 1120.7478317378525, 1197.7185361440054, 1210.594450858972, 1211.5396149463324, 690.7099018412279, 874.728834061443, 877.140402405646, 911.8039621481413, 912.2929729459589, 5656.43435656431, 5829.47534721877, 5850.151727999416, 5945.940540594625, 5947.1376650385455, 475.7549861821165, 479.9736014519235, 487.84145152825477, 488.50172823719606, 635.7475772727719, 3827.0, 3998.4002399640285, 4009.3384591542654, 4031.4154447604933, 4134.462519872457, 10645.946770266253, 11185.776284474428, 11193.608223712132, 11207.38359390225, 11213.215074944676, 11138.108951283877, 11144.888551114547, 11153.776924461628, 11168.944155279334, 11188.440577971069, 7871.685132594746, 8331.95834020838, 8355.289800366916, 8382.491151592772, 8417.915820841836, 5927.140564618193, 5982.252218472691, 6081.300650425258, 6181.289151747606, 6197.101420294122, 9646.614135434786, 10084.445355505517, 10309.896901030894, 10402.58389664405, 10424.113950314006, 10397.012283833024, 10454.950758915596, 10526.78946421052, 10631.893681063091, 10672.946635266773, 7529.623518823927, 7612.961935190288, 7716.498427602188, 7722.266384693445, 7740.3420709240345, 8231.835363292821, 8284.710035148983, 8371.0, 8376.32989360862, 8379.916200838157, 7550.66022028999, 7564.697412103675, 7604.771856844303, 7645.388368930361, 7714.537127772352, 7449.851002980018, 7530.246975302426, 7538.924610754042, 7557.35762460197, 7584.355329797029, 7036.648167591702, 7143.535670181422, 7147.0, 7156.248593897566, 7171.713131474891, 4462.866114016585, 4876.658633895593, 4877.463479017376, 5101.336826212569, 5281.524662780368, 4347.282698354863, 5049.293098966221, 5164.0, 5214.634975551675, 5218.634695571273], "value": 4583.463121711672, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [276.8435833753929, 302.1524623431275, 307.77686177521315, 312.25371362443764, 322.0531636987256, 4436.6228870545965, 5241.0, 5327.307450031495, 5390.164524498704, 5399.78400863965, 4609.79255933483, 5137.691738495693, 5217.087009773293, 5246.973765131169, 5298.284731561238, 4103.363978583309, 4114.769905624085, 4131.958680413202, 4132.2355364257555, 4134.607212314832, 3822.9426558601645, 4121.587841215869, 4133.359329303963, 4149.273877071516, 4158.875233742978, 3888.9222215555674, 4059.817308221137, 4068.7558746475156, 4093.7543747375253, 4137.77242251676, 4070.3894415837713, 4086.978255436141, 4091.8363265469347, 4097.713160078795, 4101.343784994387, 3576.123849656825, 3583.1937813991904, 3590.281943611288, 3596.1549035976523, 3601.1897323102353, 4870.902581948377, 5105.719185444799, 5151.150060240056, 5155.61332900034, 5263.736813159327, 3902.2585708715255, 4022.597740225983, 4459.7958551190995, 4693.24908014716, 4719.764011799396, 4859.910238597402, 5421.051316019721, 5583.8604034899045, 5595.832125036255, 5609.046462101453, 3010.698930106994, 3748.2878253131817, 3820.3887378019663, 3843.2121415110114, 3924.841337264522, 5133.974330128325, 5873.236479257712, 5874.3244526879525, 5878.854812675198, 5906.350301466835, 3905.7656540607654, 3906.7655940643654, 3912.1808359113147, 3925.4896863408144, 3940.349842275992, 3814.6566808987322, 3940.0, 3964.365701487748, 3969.0, 3988.4017397390626, 4440.844570440019, 4570.623275896582, 4611.2852507861335, 4618.8452886778305, 4631.606313463326, 4482.529334419839, 4741.810327586927, 5638.351589567253, 5677.489025987681, 5733.305346487145, 1077.0790973717515, 1149.4999675141341, 1249.6875781054737, 1300.8373953255843, 1328.2429015461287, 752.9736459223901, 900.9324300677475, 912.625823412411, 916.7249825052457, 917.5870858113875, 5294.205869119663, 5296.384602696137, 5306.681599104066, 5313.893722125613, 5336.839894803162, 5590.645612632469, 5774.007967251292, 5777.364489906191, 5831.300243970751, 5928.970355148283, 4671.556202160789, 4841.9031619367415, 5355.196720491957, 5433.972830135824, 5443.564514838803, 2829.0522674903727, 2912.228259511231, 3026.470367685646, 3044.893428729984, 3070.53941908711, 5344.35867695879, 5377.7580008899695, 5678.517326027251, 6047.879042419127, 6103.6032657877095, 5569.777208911598, 5638.887222255532, 6041.516678665696, 6056.728726727477, 6063.7574497020505, 4563.383943167696, 5017.673851199734, 5161.045206636634, 5306.310179676694, 5361.544268737201, 5799.681017544076, 5827.79602713903, 5863.2670916135485, 5877.678317064821, 5879.617824841372, 4643.466001409881, 5535.778568857361, 5553.805931724699, 5793.595657802133, 5854.795082172103, 5431.592630552804, 5613.635113717595, 5790.7973220937065, 6048.639056212317, 6094.451499365078, 3460.152262695555, 3605.549306336708, 4046.8178931947546, 4082.897927551835, 4094.426780250708, 5806.300070467253, 5814.244148260699, 5844.766209351578, 5851.0, 5866.794662186803, 4206.181858155104, 4528.569785870337, 5389.595780316414, 5425.403205647297, 5623.437656234508, 4368.492869959859, 4954.727489988085, 5552.028395030934, 5608.523275521463, 5630.4369563043365, 4418.469783625986, 4602.930956035595, 4951.752412379295, 5409.377921539073, 5539.556835453073, 5105.948940510547, 5650.3219613646625, 5652.745626446737, 5660.264165658438, 5701.066264277635, 4887.951120488749, 5203.27154198405, 5347.812826551052, 5525.093842624288, 5586.692731899784], "value": 4089.9686271721175, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [721.898934149219, 764.575660508418, 784.6978913118447, 798.873588240581, 839.9496030238184, 15298.388064477422, 15962.0, 16622.83377166228, 16732.749008764862, 16787.580310492212, 14827.406903723864, 15024.849751502481, 15067.342592314837, 15080.396784128649, 15082.396704131848, 668.455209004662, 833.5790425834945, 857.5755001274347, 861.4658911474894, 863.8315528471951, 679.5888487465087, 685.1230425055911, 685.8731134740065, 686.3719696477717, 687.1547995964966, 870.5168631409565, 899.1233547291404, 900.4597241654988, 909.7225346269386, 912.3750231091724, 897.4391005621486, 898.1647068226547, 899.1952202778509, 900.3292547052422, 902.1790170944474, 521.1869483605587, 663.4062514049898, 664.4983037806473, 664.6543797225464, 666.0375757031092, 11923.642290731292, 12530.874691253153, 15160.620984475367, 15253.38986440541, 15605.14171720555, 14617.12297262157, 14961.850381496155, 15033.0, 15051.247437628184, 15307.31117099722, 11265.168952677372, 11806.645800625995, 11825.586104486387, 12100.334481603508, 12176.147669663127, 3887.961120388788, 3902.5316961964745, 3907.98046009771, 4036.4550785643855, 4051.4327994080854, 110666.29478738176, 112677.0, 113021.0, 113110.30334544988, 115247.69504609861, 10860.61987830438, 11254.43727813606, 11428.885711142948, 11519.827202591969, 11566.363849988164, 23299.0, 23674.64488032681, 23881.04475820948, 24334.26997190087, 24405.26784196477, 8000.8799868002025, 8065.475744076616, 8129.0, 8293.253607175384, 8395.958020209982, 4220.451341325608, 4379.934300985487, 4487.371767952489, 4514.052049069732, 4527.7736113194205, 3689.1883785567134, 3794.127350709297, 3795.886123416302, 3800.4489349044234, 3809.4285857121654, 673.6160388578561, 674.8852695041854, 675.787127054976, 683.6513378177166, 689.1351354050735, 591.5651995783096, 614.2506142506136, 632.6868200240818, 650.9010570950227, 701.4388489208612, 7936.682532698743, 9482.241420686329, 9484.430934143973, 9580.616775329048, 9600.567974441166, 597.9820605381846, 659.9307072757388, 672.4821887146869, 675.7938828657209, 679.5481005131631, 4449.955500444954, 4651.488336283006, 4710.528947105262, 4715.599174070242, 4768.165571025057, 159321.2033939823, 161942.0, 166539.0, 167277.16361418116, 171141.0, 140239.29880350738, 140850.88723669155, 142509.0, 143740.0, 145336.27331863483, 118255.58316377, 122216.38891805484, 124446.0, 126953.0, 128134.0, 8084.312833409226, 8652.697155599524, 8677.262432693291, 9044.0, 9056.909430905871, 58800.11799822921, 67849.0, 68184.65907670629, 68544.31455685379, 69501.0, 94910.0, 97014.54478182692, 99870.00129998606, 99894.0, 100083.0, 12173.69565760863, 12873.291968941423, 12874.935625321814, 12906.161099528501, 13352.332383380986, 13856.930715346762, 14060.0, 14410.639734006734, 14575.416983320549, 15811.683766324839, 13504.324783760969, 13544.187348759106, 14362.856371436152, 14368.712625747636, 14707.55877323682, 11554.595589154676, 13800.0, 14040.508582199574, 14058.789118163031, 14588.927055364655, 13422.463101476222, 13461.326933653474, 13548.25484598317, 13931.0, 14006.929965350108, 11101.333919964827, 11105.0, 11185.66443006711, 11857.644270671894, 11968.940155299517, 10037.5483103262, 11573.18987670855, 11632.429622000922, 11678.599206269892, 11680.47437865315], "value": 7980.381834919772, "unit": "score"}], "name": "dromaeo_css", "value": 7351.237557270438, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 112.0, 113.0, 113.0, 112.0, 114.0, 113.0, 113.0, 113.0, 114.0], "value": 113.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 136.0, 107.0, 168.0, 134.0, 109.0, 108.0, 108.0, 138.0, 109.0], "value": 127.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 186.0, 181.0, 186.0, 184.0, 182.0, 183.0, 182.0, 182.0, 181.0], "value": 183.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 56.0, 61.0, 107.0, 85.0, 81.0, 50.0, 74.0, 100.0, 78.0], "value": 77.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 72.0, 93.0, 69.0, 68.0, 68.0, 92.0, 67.0, 68.0, 92.0], "value": 77.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 88.0, 86.0, 88.0, 85.0, 90.0, 86.0, 89.0, 85.0], "value": 87.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 95.0, 94.0, 97.0, 95.0, 89.0, 131.0, 146.0], "value": 103.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 87.0, 86.0, 84.0, 93.0, 84.0, 86.0, 86.0, 87.0], "value": 86.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 51.0, 52.0, 51.0, 56.0, 56.0, 57.0, 55.0, 55.0, 55.0], "value": 54.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 75.0, 77.0, 73.0, 76.0, 70.0, 68.0, 70.0, 70.0, 70.0], "value": 71.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 80.0, 91.0, 99.0, 98.0, 76.0, 79.0, 81.0, 82.0], "value": 84.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 148.0, 144.0, 146.0, 136.0, 139.0, 137.0, 133.0, 178.0, 158.0], "value": 146.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 161.0, 160.0, 156.0, 163.0, 161.0, 159.0, 217.0, 182.0], "value": 168.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 67.0, 67.0, 67.0, 66.0, 68.0, 65.0, 66.0, 65.0], "value": 66.3, "unit": "score"}], "name": "kraken", "value": 1446.1, "alertThreshold": 2.0}]} 02:22:24 INFO - Return code: 0 02:22:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:22:24 INFO - # TBPL SUCCESS # 02:22:24 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:22:24 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:22:24 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:22:24 INFO - 2016-09-23 02:22:24.364 screenresolution[1677:11316] starting screenresolution argv=screenresolution get 02:22:24 INFO - 2016-09-23 02:22:24.366 screenresolution[1677:11316] Display 0: 1600x1200x32@60 02:22:24 INFO - 2016-09-23 02:22:24.372 screenresolution[1678:11319] starting screenresolution argv=screenresolution list 02:22:24 INFO - Available Modes on Display 0 02:22:24 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:22:24 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:22:24 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:22:24 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:22:24 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:22:24 INFO - Intel Iris: 02:22:24 INFO - Chipset Model: Intel Iris 02:22:24 INFO - Type: GPU 02:22:24 INFO - Bus: Built-In 02:22:24 INFO - VRAM (Dynamic, Max): 1536 MB 02:22:24 INFO - Vendor: Intel (0x8086) 02:22:24 INFO - Device ID: 0x0a2e 02:22:24 INFO - Revision ID: 0x0009 02:22:24 INFO - Displays: 02:22:24 INFO - Display: 02:22:24 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:22:24 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:22:24 INFO - Display Serial Number: 1600x1200 60 02:22:24 INFO - Main Display: Yes 02:22:24 INFO - Mirror: Off 02:22:24 INFO - Online: Yes 02:22:24 INFO - Rotation: Supported 02:22:24 INFO - Return code: 0 02:22:24 INFO - Running post-action listener: _resource_record_post_action 02:22:24 INFO - [mozharness: 2016-09-23 09:22:24.605713Z] Finished run-tests step (success) 02:22:24 INFO - Running post-run listener: _resource_record_post_run 02:22:24 INFO - Total resource usage - Wall time: 1209s; CPU: 54.0%; Read bytes: 33012736; Write bytes: 661855232; Read time: 312; Write time: 1933 02:22:24 INFO - TinderboxPrint: CPU usage
53.6% 02:22:24 INFO - TinderboxPrint: I/O read bytes / time
33,012,736 / 312 02:22:24 INFO - TinderboxPrint: I/O write bytes / time
661,855,232 / 1,933 02:22:24 INFO - TinderboxPrint: CPU idle
2,246.5 (46.4%) 02:22:24 INFO - TinderboxPrint: CPU system
970.7 (20.1%) 02:22:24 INFO - TinderboxPrint: CPU user
1,620.3 (33.5%) 02:22:24 INFO - TinderboxPrint: Swap in / out
391,917,568 / 0 02:22:24 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 354777600; Write bytes: 356370432; Read time: 27442; Write time: 632 02:22:24 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 32082944; Write bytes: 295306240; Read time: 298; Write time: 1204 02:22:25 INFO - Running post-run listener: _upload_blobber_files 02:22:25 INFO - Blob upload gear active. 02:22:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:22:25 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 02:22:25 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'] 02:22:25 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 02:22:25 INFO - (blobuploader) - INFO - Open directory for files ... 02:22:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:22:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:22:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:22:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:22:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:22:26 INFO - (blobuploader) - INFO - Done attempting. 02:22:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:22:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:22:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:22:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:22:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:22:27 INFO - (blobuploader) - INFO - Done attempting. 02:22:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:22:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:22:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:22:29 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:22:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:22:29 INFO - (blobuploader) - INFO - Done attempting. 02:22:29 INFO - (blobuploader) - INFO - Iteration through files over. 02:22:29 INFO - Return code: 0 02:22:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:22:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:22:29 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/52f3102e82cafcd90104f1cb59016bd55b6bf26a555f15f10f569e2a599c12d279f6b22eedbac412d00abada39f3575f1e690cd1f34b71e10c9bcaf86b2e69f7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ba0e94f5282386d8eb70bcfb8746772ece96bad3cde25a66a4ea74c38612b41e9e83012334cc99a5b597b3cbe69ed5563461b8382ec708f2e21e30955ee3f8b3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/abea797d86586fc59b6c9d88fe1223d93f1e79607edac5823d6edbcff2dc05a5791a28a15a84013ad0c34f90cfd42682ccda668946faf4b709ba313e859bc915"} 02:22:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:22:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:22:29 INFO - Contents: 02:22:29 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/52f3102e82cafcd90104f1cb59016bd55b6bf26a555f15f10f569e2a599c12d279f6b22eedbac412d00abada39f3575f1e690cd1f34b71e10c9bcaf86b2e69f7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ba0e94f5282386d8eb70bcfb8746772ece96bad3cde25a66a4ea74c38612b41e9e83012334cc99a5b597b3cbe69ed5563461b8382ec708f2e21e30955ee3f8b3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/abea797d86586fc59b6c9d88fe1223d93f1e79607edac5823d6edbcff2dc05a5791a28a15a84013ad0c34f90cfd42682ccda668946faf4b709ba313e859bc915"} 02:22:29 INFO - Running post-run listener: copy_logs_to_upload_dir 02:22:29 INFO - Copying logs to upload dir... 02:22:29 INFO - mkdir: /builds/slave/test/build/upload/logs 02:22:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.220169 ========= master_lag: 2.29 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-09-23 02:22:32.186676) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-23 02:22:32.190584) ========= 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.wgDAYsOBUZ/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.W0gnHPR8Pn/Listeners TMPDIR=/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/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/52f3102e82cafcd90104f1cb59016bd55b6bf26a555f15f10f569e2a599c12d279f6b22eedbac412d00abada39f3575f1e690cd1f34b71e10c9bcaf86b2e69f7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ba0e94f5282386d8eb70bcfb8746772ece96bad3cde25a66a4ea74c38612b41e9e83012334cc99a5b597b3cbe69ed5563461b8382ec708f2e21e30955ee3f8b3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/abea797d86586fc59b6c9d88fe1223d93f1e79607edac5823d6edbcff2dc05a5791a28a15a84013ad0c34f90cfd42682ccda668946faf4b709ba313e859bc915"} build_url:https://queue.taskcluster.net/v1/task/Kz720596ReyKn4TaebBmZw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010569 build_url: 'https://queue.taskcluster.net/v1/task/Kz720596ReyKn4TaebBmZw/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/52f3102e82cafcd90104f1cb59016bd55b6bf26a555f15f10f569e2a599c12d279f6b22eedbac412d00abada39f3575f1e690cd1f34b71e10c9bcaf86b2e69f7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ba0e94f5282386d8eb70bcfb8746772ece96bad3cde25a66a4ea74c38612b41e9e83012334cc99a5b597b3cbe69ed5563461b8382ec708f2e21e30955ee3f8b3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/abea797d86586fc59b6c9d88fe1223d93f1e79607edac5823d6edbcff2dc05a5791a28a15a84013ad0c34f90cfd42682ccda668946faf4b709ba313e859bc915"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-23 02:22:32.223405) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 02:22:32.223704) ========= 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.wgDAYsOBUZ/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.W0gnHPR8Pn/Listeners TMPDIR=/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/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.005136 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 02:22:32.271750) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-23 02:22:32.272023) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-23 02:22:32.272314) ========= ========= Total master_lag: 2.42 =========