builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0359 starttime: 1478190389.28 results: success (0) buildid: 20161103062923 builduid: 873b076da76044c3a085ff6ee703de28 revision: c31d95b2a3cd435ffd4808c5f939fe5c9c1a7648 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-03 09:26:29.276869) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-03 09:26:29.277335) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-03 09:26:29.277616) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-03 09:26:29.301451) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-03 09:26:29.301890) ========= 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.HXOxP4PXz2/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.3HzMKOHxr8/Listeners TMPDIR=/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/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-11-03 09:26:29-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 151M=0s 2016-11-03 09:26:29 (151 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.153959 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-03 09:26:29.477679) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-03 09:26:29.478006) ========= 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.HXOxP4PXz2/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.3HzMKOHxr8/Listeners TMPDIR=/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/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.019901 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-03 09:26:29.526749) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-03 09:26:29.527269) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev c31d95b2a3cd435ffd4808c5f939fe5c9c1a7648 --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 c31d95b2a3cd435ffd4808c5f939fe5c9c1a7648 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.HXOxP4PXz2/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.3HzMKOHxr8/Listeners TMPDIR=/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/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-11-03 09:26:29,609 truncating revision to first 12 chars 2016-11-03 09:26:29,609 Setting DEBUG logging. 2016-11-03 09:26:29,609 attempt 1/10 2016-11-03 09:26:29,609 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/c31d95b2a3cd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-03 09:26:30,360 unpacking tar archive at: mozilla-aurora-c31d95b2a3cd/testing/mozharness/ program finished with exit code 0 elapsedTime=1.031515 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-03 09:26:30.580724) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-03 09:26:30.581072) ========= script_repo_revision: c31d95b2a3cd435ffd4808c5f939fe5c9c1a7648 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-03 09:26:30.581488) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-03 09:26:30.581752) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-03 09:26:30.600046) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-11-03 09:26:30.600389) ========= /tools/buildbot/bin/python -u 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', '-u', '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.HXOxP4PXz2/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.3HzMKOHxr8/Listeners TMPDIR=/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/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 09:26:30 INFO - MultiFileLogger online at 20161103 09:26:30 in /builds/slave/test 09:26:30 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 09:26:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:26:30 INFO - {'append_to_log': False, 09:26:30 INFO - 'base_work_dir': '/builds/slave/test', 09:26:30 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:26:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:26:30 INFO - 'branch': 'Mozilla-Aurora', 09:26:30 INFO - 'buildbot_json_path': 'buildprops.json', 09:26:30 INFO - 'config_files': ('talos/mac_config.py',), 09:26:30 INFO - 'default_actions': ('clobber', 09:26:30 INFO - 'read-buildbot-config', 09:26:30 INFO - 'download-and-extract', 09:26:30 INFO - 'populate-webroot', 09:26:30 INFO - 'create-virtualenv', 09:26:30 INFO - 'install', 09:26:30 INFO - 'run-tests'), 09:26:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:26:30 INFO - 'download_minidump_stackwalk': True, 09:26:30 INFO - 'download_symbols': 'ondemand', 09:26:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:26:30 INFO - 'tooltool.py': '/tools/tooltool.py', 09:26:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:26:30 INFO - '/tools/misc-python/virtualenv.py')}, 09:26:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:26:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:26:30 INFO - 'installer_path': 'installer.exe', 09:26:30 INFO - 'log_level': 'info', 09:26:30 INFO - 'log_name': 'talos', 09:26:30 INFO - 'log_to_console': True, 09:26:30 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:26:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:26:30 INFO - 'opt_config_files': (), 09:26:30 INFO - 'pip_index': False, 09:26:30 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:26:30 INFO - 'cmd': ('bash', 09:26:30 INFO - '-c', 09:26:30 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:26:30 INFO - 'enabled': True, 09:26:30 INFO - 'halt_on_failure': False, 09:26:30 INFO - 'name': 'check_screen_resolution'},), 09:26:30 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:26:30 INFO - 'cmd': ('bash', 09:26:30 INFO - '-c', 09:26:30 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:26:30 INFO - 'enabled': True, 09:26:30 INFO - 'halt_on_failure': False, 09:26:30 INFO - 'name': 'check_screen_resolution'},), 09:26:30 INFO - 'run_cmd_checks_enabled': True, 09:26:30 INFO - 'sps_profile': False, 09:26:30 INFO - 'sps_profile_interval': 0, 09:26:30 INFO - 'suite': 'dromaeojs', 09:26:30 INFO - 'system_bits': '32', 09:26:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:26:30 INFO - 'title': 't-yosemite-r7-0359', 09:26:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:26:30 INFO - 'use_talos_json': True, 09:26:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:26:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:26:30 INFO - 'work_dir': 'build'} 09:26:30 INFO - [mozharness: 2016-11-03 16:26:30.793036Z] Running clobber step. 09:26:30 INFO - Running pre-action listener: _resource_record_pre_action 09:26:30 INFO - Running main action method: clobber 09:26:30 INFO - rmtree: /builds/slave/test/build 09:26:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:26:32 INFO - Running post-action listener: _resource_record_post_action 09:26:32 INFO - [mozharness: 2016-11-03 16:26:32.400212Z] Finished clobber step (success) 09:26:32 INFO - [mozharness: 2016-11-03 16:26:32.400378Z] Running read-buildbot-config step. 09:26:32 INFO - Running pre-action listener: _resource_record_pre_action 09:26:32 INFO - Running main action method: read_buildbot_config 09:26:32 INFO - Using buildbot properties: 09:26:32 INFO - { 09:26:32 INFO - "project": "", 09:26:32 INFO - "product": "firefox", 09:26:32 INFO - "script_repo_revision": "production", 09:26:32 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 09:26:32 INFO - "repository": "", 09:26:32 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 09:26:32 INFO - "buildid": "20161103062923", 09:26:32 INFO - "pgo_build": "False", 09:26:32 INFO - "basedir": "/builds/slave/test", 09:26:32 INFO - "buildnumber": 14, 09:26:32 INFO - "slavename": "t-yosemite-r7-0359", 09:26:32 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 09:26:32 INFO - "platform": "yosemite_r7", 09:26:32 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 09:26:32 INFO - "branch": "mozilla-aurora", 09:26:32 INFO - "repo_path": "releases/mozilla-aurora", 09:26:32 INFO - "revision": "c31d95b2a3cd435ffd4808c5f939fe5c9c1a7648", 09:26:32 INFO - "stage_platform": "macosx64", 09:26:32 INFO - "builduid": "873b076da76044c3a085ff6ee703de28", 09:26:32 INFO - "slavebuilddir": "test" 09:26:32 INFO - } 09:26:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ih8HRY3cQJ60r4IrY3xr0Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 09:26:32 INFO - Running post-action listener: _resource_record_post_action 09:26:32 INFO - [mozharness: 2016-11-03 16:26:32.403822Z] Finished read-buildbot-config step (success) 09:26:32 INFO - [mozharness: 2016-11-03 16:26:32.403946Z] Running download-and-extract step. 09:26:32 INFO - Running pre-action listener: _resource_record_pre_action 09:26:32 INFO - Running main action method: download_and_extract 09:26:32 INFO - mkdir: /builds/slave/test/build/tests 09:26:32 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')]} 09:26:32 INFO - trying https://queue.taskcluster.net/v1/task/Ih8HRY3cQJ60r4IrY3xr0Q/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 09:26:32 INFO - Downloading https://queue.taskcluster.net/v1/task/Ih8HRY3cQJ60r4IrY3xr0Q/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 09:26:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ih8HRY3cQJ60r4IrY3xr0Q/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 09:26:33 INFO - Downloaded 1199 bytes. 09:26:33 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 09:26:33 INFO - Using the following test package requirements: 09:26:33 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 09:26:33 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 09:26:33 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 09:26:33 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 09:26:33 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 09:26:33 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 09:26:33 INFO - u'jsshell-mac.zip'], 09:26:33 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 09:26:33 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 09:26:33 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 09:26:33 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 09:26:33 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 09:26:33 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 09:26:33 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 09:26:33 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 09:26:33 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 09:26:33 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 09:26:33 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 09:26:33 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 09:26:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ih8HRY3cQJ60r4IrY3xr0Q/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 09:26:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ih8HRY3cQJ60r4IrY3xr0Q/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 09:26:33 INFO - Fetch https://queue.taskcluster.net/v1/task/Ih8HRY3cQJ60r4IrY3xr0Q/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 09:26:34 INFO - Expected file size: 16421521 09:26:41 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 09:26:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ih8HRY3cQJ60r4IrY3xr0Q/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 09:26:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ih8HRY3cQJ60r4IrY3xr0Q/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 09:26:41 INFO - Fetch https://queue.taskcluster.net/v1/task/Ih8HRY3cQJ60r4IrY3xr0Q/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 09:26:41 INFO - Expected file size: 16421521 09:26:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ih8HRY3cQJ60r4IrY3xr0Q/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 09:26:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ih8HRY3cQJ60r4IrY3xr0Q/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 09:26:48 INFO - Fetch https://queue.taskcluster.net/v1/task/Ih8HRY3cQJ60r4IrY3xr0Q/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 09:26:49 INFO - Expected file size: 14414089 09:26:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:26:49 INFO - trying https://queue.taskcluster.net/v1/task/Ih8HRY3cQJ60r4IrY3xr0Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 09:26:49 INFO - Downloading https://queue.taskcluster.net/v1/task/Ih8HRY3cQJ60r4IrY3xr0Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 09:26:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ih8HRY3cQJ60r4IrY3xr0Q/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 09:26:52 INFO - Downloaded 115464136 bytes. 09:26:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ih8HRY3cQJ60r4IrY3xr0Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 09:26:52 INFO - mkdir: /builds/slave/test/properties 09:26:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:26:52 INFO - Writing to file /builds/slave/test/properties/build_url 09:26:52 INFO - Contents: 09:26:52 INFO - build_url:https://queue.taskcluster.net/v1/task/Ih8HRY3cQJ60r4IrY3xr0Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 09:26:53 INFO - Running post-action listener: _resource_record_post_action 09:26:53 INFO - Running post-action listener: set_extra_try_arguments 09:26:53 INFO - [mozharness: 2016-11-03 16:26:53.176096Z] Finished download-and-extract step (success) 09:26:53 INFO - [mozharness: 2016-11-03 16:26:53.176217Z] Running populate-webroot step. 09:26:53 INFO - Running pre-action listener: _resource_record_pre_action 09:26:53 INFO - Running main action method: populate_webroot 09:26:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:26:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:26:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:26:53 INFO - '--tppagecycles', 09:26:53 INFO - '7'], 09:26:53 INFO - 'tests': ['tsvgm']}}, 09:26:53 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:26:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:26:53 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:26:53 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:26:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:26:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:26:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:26:53 INFO - 'talos_options': ['--disable-e10s'], 09:26:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:26:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:26:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:26:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:26:53 INFO - 'talos_options': ['--disable-e10s'], 09:26:53 INFO - 'tests': ['damp', 'tps']}, 09:26:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:26:53 INFO - 'tests': ['damp', 'tps']}, 09:26:53 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:26:53 INFO - 'tests': ['dromaeo_dom']}, 09:26:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:26:53 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:26:53 INFO - 'tests': ['basic_compositor_video']}, 09:26:53 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:26:53 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:26:53 INFO - 'tests': ['a11yr', 09:26:53 INFO - 'ts_paint', 09:26:53 INFO - 'tpaint', 09:26:53 INFO - 'sessionrestore', 09:26:53 INFO - 'sessionrestore_no_auto_restore', 09:26:53 INFO - 'tabpaint']}, 09:26:53 INFO - 'other-e10s': {'tests': ['a11yr', 09:26:53 INFO - 'ts_paint', 09:26:53 INFO - 'tpaint', 09:26:53 INFO - 'sessionrestore', 09:26:53 INFO - 'sessionrestore_no_auto_restore', 09:26:53 INFO - 'tabpaint']}, 09:26:53 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:26:53 INFO - 'ts_paint', 09:26:53 INFO - 'tpaint', 09:26:53 INFO - 'sessionrestore', 09:26:53 INFO - 'sessionrestore_no_auto_restore', 09:26:53 INFO - 'tabpaint']}, 09:26:53 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:26:53 INFO - 'ts_paint', 09:26:53 INFO - 'tpaint', 09:26:53 INFO - 'sessionrestore', 09:26:53 INFO - 'sessionrestore_no_auto_restore', 09:26:53 INFO - 'tabpaint']}, 09:26:53 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:26:53 INFO - 'tests': ['a11yr', 09:26:53 INFO - 'ts_paint', 09:26:53 INFO - 'tpaint', 09:26:53 INFO - 'sessionrestore', 09:26:53 INFO - 'sessionrestore_no_auto_restore', 09:26:53 INFO - 'tabpaint']}, 09:26:53 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:26:53 INFO - 'tests': ['a11yr', 09:26:53 INFO - 'ts_paint', 09:26:53 INFO - 'tpaint', 09:26:53 INFO - 'sessionrestore', 09:26:53 INFO - 'sessionrestore_no_auto_restore', 09:26:53 INFO - 'tabpaint']}, 09:26:53 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:26:53 INFO - 'tests': ['tsvgx', 09:26:53 INFO - 'tsvgr_opacity', 09:26:53 INFO - 'tart', 09:26:53 INFO - 'tscrollx', 09:26:53 INFO - 'cart']}, 09:26:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:26:53 INFO - 'tsvgr_opacity', 09:26:53 INFO - 'tart', 09:26:53 INFO - 'tscrollx', 09:26:53 INFO - 'cart']}, 09:26:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:26:53 INFO - 'talos_options': ['--disable-e10s'], 09:26:53 INFO - 'tests': ['tp5o']}, 09:26:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:26:53 INFO - 'tests': ['tp5o']}, 09:26:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:26:53 INFO - 'talos_options': ['--disable-e10s', 09:26:53 INFO - '--xperf_path', 09:26:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:26:53 INFO - 'tests': ['tp5n']}, 09:26:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:26:53 INFO - 'talos_options': ['--xperf_path', 09:26:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:26:53 INFO - 'tests': ['tp5n']}}, 09:26:53 INFO - 'talos.zip': {'path': '', 09:26:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:26:53 INFO - Running post-action listener: _resource_record_post_action 09:26:53 INFO - [mozharness: 2016-11-03 16:26:53.194799Z] Finished populate-webroot step (success) 09:26:53 INFO - [mozharness: 2016-11-03 16:26:53.194932Z] Running create-virtualenv step. 09:26:53 INFO - Running pre-action listener: _resource_record_pre_action 09:26:53 INFO - Running main action method: create_virtualenv 09:26:53 INFO - Creating virtualenv /builds/slave/test/build/venv 09:26:53 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 09:26:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:26:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:26:53 INFO - Using real prefix '/tools/python27' 09:26:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:26:54 INFO - Installing distribute.............................................................................................................................................................................................done. 09:26:56 INFO - Installing pip.................done. 09:26:56 INFO - Return code: 0 09:26:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:26:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:26:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:26:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:26:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:26:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f1c2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f138570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7e0cc3340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10efd6d30>, '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 0x10ee3cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10efceb20>, '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.HXOxP4PXz2/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.3HzMKOHxr8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/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 09:26:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:26:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:26:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HXOxP4PXz2/Render', 09:26:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:26:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:26:56 INFO - 'HOME': '/Users/cltbld', 09:26:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:26:56 INFO - 'LOGNAME': 'cltbld', 09:26:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:26:56 INFO - 'MOZ_NO_REMOTE': '1', 09:26:56 INFO - 'NO_EM_RESTART': '1', 09:26:56 INFO - 'PAGER': '/bin/cat', 09:26:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:26:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:26:56 INFO - 'PWD': '/builds/slave/test', 09:26:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:26:56 INFO - 'SHELL': '/bin/bash', 09:26:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3HzMKOHxr8/Listeners', 09:26:56 INFO - 'TMPDIR': '/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/', 09:26:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:26:56 INFO - 'USER': 'cltbld', 09:26:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:26:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:26:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:26:56 INFO - 'XPC_FLAGS': '0x0', 09:26:56 INFO - 'XPC_SERVICE_NAME': '0', 09:26:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:26:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:26:57 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 09:26:57 INFO - Cleaning up... 09:26:57 INFO - Return code: 0 09:26:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:26:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:26:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:26:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:26:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:26:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10f1c2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f138570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7e0cc3340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10efd6d30>, '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 0x10ee3cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10efceb20>, '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.HXOxP4PXz2/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.3HzMKOHxr8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/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 09:26:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:26:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:26:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HXOxP4PXz2/Render', 09:26:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:26:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:26:57 INFO - 'HOME': '/Users/cltbld', 09:26:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:26:57 INFO - 'LOGNAME': 'cltbld', 09:26:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:26:57 INFO - 'MOZ_NO_REMOTE': '1', 09:26:57 INFO - 'NO_EM_RESTART': '1', 09:26:57 INFO - 'PAGER': '/bin/cat', 09:26:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:26:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:26:57 INFO - 'PWD': '/builds/slave/test', 09:26:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:26:57 INFO - 'SHELL': '/bin/bash', 09:26:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3HzMKOHxr8/Listeners', 09:26:57 INFO - 'TMPDIR': '/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/', 09:26:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:26:57 INFO - 'USER': 'cltbld', 09:26:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:26:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:26:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:26:57 INFO - 'XPC_FLAGS': '0x0', 09:26:57 INFO - 'XPC_SERVICE_NAME': '0', 09:26:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:26:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:26:57 INFO - Downloading/unpacking psutil>=3.1.1 09:26: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 09:26: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 09:26: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 09:26: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 09:26: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 09:26: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 09:27:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:27:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:27:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:27:00 INFO - Installing collected packages: psutil 09:27:00 INFO - Running setup.py install for psutil 09:27:00 INFO - building 'psutil._psutil_osx' extension 09:27:00 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 09:27:01 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 09:27:01 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 09:27:01 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 09:27:01 INFO - building 'psutil._psutil_posix' extension 09:27:01 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 09:27:01 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:27:01 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:27:01 INFO - ^ 09:27:01 INFO - 1 warning generated. 09:27:01 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 09:27:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:27:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:27:01 INFO - Successfully installed psutil 09:27:01 INFO - Cleaning up... 09:27:01 INFO - Return code: 0 09:27:01 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:27:01 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')]} 09:27:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:27:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:27:01 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')]} 09:27:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:27:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:27:01 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 0x10f1c2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f138570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7e0cc3340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10efd6d30>, '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 0x10ee3cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10efceb20>, '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.HXOxP4PXz2/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.3HzMKOHxr8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/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 09:27:01 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 09:27:01 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 09:27:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HXOxP4PXz2/Render', 09:27:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:27:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:27:01 INFO - 'HOME': '/Users/cltbld', 09:27:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:27:01 INFO - 'LOGNAME': 'cltbld', 09:27:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:27:01 INFO - 'MOZ_NO_REMOTE': '1', 09:27:01 INFO - 'NO_EM_RESTART': '1', 09:27:01 INFO - 'PAGER': '/bin/cat', 09:27:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:27:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:27:01 INFO - 'PWD': '/builds/slave/test', 09:27:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:27:01 INFO - 'SHELL': '/bin/bash', 09:27:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3HzMKOHxr8/Listeners', 09:27:01 INFO - 'TMPDIR': '/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/', 09:27:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:27:01 INFO - 'USER': 'cltbld', 09:27:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:27:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:27:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:27:01 INFO - 'XPC_FLAGS': '0x0', 09:27:01 INFO - 'XPC_SERVICE_NAME': '0', 09:27:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:27:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:27:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:27: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 09:27: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 09:27: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 09:27: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 09:27: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 09:27: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 09:27:04 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:27:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:27:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:27:04 INFO - Installing collected packages: mozsystemmonitor 09:27:04 INFO - Running setup.py install for mozsystemmonitor 09:27:04 INFO - Successfully installed mozsystemmonitor 09:27:04 INFO - Cleaning up... 09:27:04 INFO - Return code: 0 09:27:04 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:27:04 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')]} 09:27:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:27:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:27:04 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')]} 09:27:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:27:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:27:04 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 0x10f1c2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f138570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7e0cc3340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10efd6d30>, '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 0x10ee3cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10efceb20>, '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.HXOxP4PXz2/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.3HzMKOHxr8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/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 09:27:04 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 09:27:04 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 09:27:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HXOxP4PXz2/Render', 09:27:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:27:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:27:04 INFO - 'HOME': '/Users/cltbld', 09:27:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:27:04 INFO - 'LOGNAME': 'cltbld', 09:27:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:27:04 INFO - 'MOZ_NO_REMOTE': '1', 09:27:04 INFO - 'NO_EM_RESTART': '1', 09:27:04 INFO - 'PAGER': '/bin/cat', 09:27:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:27:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:27:04 INFO - 'PWD': '/builds/slave/test', 09:27:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:27:04 INFO - 'SHELL': '/bin/bash', 09:27:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3HzMKOHxr8/Listeners', 09:27:04 INFO - 'TMPDIR': '/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/', 09:27:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:27:04 INFO - 'USER': 'cltbld', 09:27:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:27:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:27:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:27:04 INFO - 'XPC_FLAGS': '0x0', 09:27:04 INFO - 'XPC_SERVICE_NAME': '0', 09:27:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:27:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:27:04 INFO - Downloading/unpacking jsonschema==2.5.1 09:27:04 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 09:27:04 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 09:27:04 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 09:27:04 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 09:27:04 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 09:27:04 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 09:27:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:27:07 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:27:07 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 09:27:07 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 09:27:07 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 09:27:07 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 09:27:07 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 09:27:07 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 09:27:07 INFO - Downloading functools32-3.2.3-2.tar.gz 09:27:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:27:07 INFO - warning: no files found matching '*.txt' 09:27:07 INFO - no previously-included directories found matching 'build' 09:27:07 INFO - no previously-included directories found matching 'dist' 09:27:07 INFO - no previously-included directories found matching '.git*' 09:27:07 INFO - Installing collected packages: jsonschema, functools32 09:27:07 INFO - Running setup.py install for functools32 09:27:08 INFO - warning: no files found matching '*.txt' 09:27:08 INFO - no previously-included directories found matching 'build' 09:27:08 INFO - no previously-included directories found matching 'dist' 09:27:08 INFO - no previously-included directories found matching '.git*' 09:27:08 INFO - Successfully installed jsonschema functools32 09:27:08 INFO - Cleaning up... 09:27:08 INFO - Return code: 0 09:27:08 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:27: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')]} 09:27:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:27:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:27: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')]} 09:27:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:27:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:27:08 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 0x10f1c2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f138570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7e0cc3340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10efd6d30>, '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 0x10ee3cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10efceb20>, '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.HXOxP4PXz2/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.3HzMKOHxr8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/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 09:27:08 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 09:27:08 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 09:27:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HXOxP4PXz2/Render', 09:27:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:27:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:27:08 INFO - 'HOME': '/Users/cltbld', 09:27:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:27:08 INFO - 'LOGNAME': 'cltbld', 09:27:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:27:08 INFO - 'MOZ_NO_REMOTE': '1', 09:27:08 INFO - 'NO_EM_RESTART': '1', 09:27:08 INFO - 'PAGER': '/bin/cat', 09:27:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:27:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:27:08 INFO - 'PWD': '/builds/slave/test', 09:27:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:27:08 INFO - 'SHELL': '/bin/bash', 09:27:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3HzMKOHxr8/Listeners', 09:27:08 INFO - 'TMPDIR': '/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/', 09:27:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:27:08 INFO - 'USER': 'cltbld', 09:27:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:27:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:27:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:27:08 INFO - 'XPC_FLAGS': '0x0', 09:27:08 INFO - 'XPC_SERVICE_NAME': '0', 09:27:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:27:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:27:08 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:27:08 INFO - Cleaning up... 09:27:08 INFO - Return code: 0 09:27:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:27: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')]} 09:27:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:27:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:27: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')]} 09:27:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:27:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:27:08 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 0x10f1c2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f138570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7e0cc3340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10efd6d30>, '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 0x10ee3cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10efceb20>, '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.HXOxP4PXz2/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.3HzMKOHxr8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/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 09:27:08 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 09:27:08 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 09:27:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HXOxP4PXz2/Render', 09:27:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:27:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:27:08 INFO - 'HOME': '/Users/cltbld', 09:27:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:27:08 INFO - 'LOGNAME': 'cltbld', 09:27:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:27:08 INFO - 'MOZ_NO_REMOTE': '1', 09:27:08 INFO - 'NO_EM_RESTART': '1', 09:27:08 INFO - 'PAGER': '/bin/cat', 09:27:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:27:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:27:08 INFO - 'PWD': '/builds/slave/test', 09:27:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:27:08 INFO - 'SHELL': '/bin/bash', 09:27:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3HzMKOHxr8/Listeners', 09:27:08 INFO - 'TMPDIR': '/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/', 09:27:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:27:08 INFO - 'USER': 'cltbld', 09:27:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:27:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:27:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:27:08 INFO - 'XPC_FLAGS': '0x0', 09:27:08 INFO - 'XPC_SERVICE_NAME': '0', 09:27:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:27:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:27:08 INFO - Downloading/unpacking blobuploader==1.2.4 09:27:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:27:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:27:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:27:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:27:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:27:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:27:11 INFO - Downloading blobuploader-1.2.4.tar.gz 09:27:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:27:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:27:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:27:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:27:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:27:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:27:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:27:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:27:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:27:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:27:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:27:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:27:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:27:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:27:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:27:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:27:12 INFO - Downloading docopt-0.6.1.tar.gz 09:27:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:27:12 INFO - Installing collected packages: blobuploader, requests, docopt 09:27:12 INFO - Running setup.py install for blobuploader 09:27:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:27:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:27:12 INFO - Running setup.py install for requests 09:27:13 INFO - Running setup.py install for docopt 09:27:13 INFO - Successfully installed blobuploader requests docopt 09:27:13 INFO - Cleaning up... 09:27:13 INFO - Return code: 0 09:27:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:27: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')]} 09:27:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:27:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:27: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')]} 09:27:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:27:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:27:13 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 0x10f1c2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f138570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7e0cc3340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10efd6d30>, '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 0x10ee3cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10efceb20>, '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.HXOxP4PXz2/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.3HzMKOHxr8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/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 09:27:13 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 09:27:13 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 09:27:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HXOxP4PXz2/Render', 09:27:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:27:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:27:13 INFO - 'HOME': '/Users/cltbld', 09:27:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:27:13 INFO - 'LOGNAME': 'cltbld', 09:27:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:27:13 INFO - 'MOZ_NO_REMOTE': '1', 09:27:13 INFO - 'NO_EM_RESTART': '1', 09:27:13 INFO - 'PAGER': '/bin/cat', 09:27:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:27:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:27:13 INFO - 'PWD': '/builds/slave/test', 09:27:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:27:13 INFO - 'SHELL': '/bin/bash', 09:27:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3HzMKOHxr8/Listeners', 09:27:13 INFO - 'TMPDIR': '/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/', 09:27:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:27:13 INFO - 'USER': 'cltbld', 09:27:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:27:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:27:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:27:13 INFO - 'XPC_FLAGS': '0x0', 09:27:13 INFO - 'XPC_SERVICE_NAME': '0', 09:27:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:27:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:27:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:27:13 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-he6kkR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:27:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:27:13 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-5qjFAe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:27:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:27:13 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-IoyDL8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:27:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:27:13 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-en8QEw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:27:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:27:13 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-T6k4dR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:27:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:27:14 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-fu8jbD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:27:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:27:14 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-h2Tlvd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:27:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:27:14 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-PyJ7Ly-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:27:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:27:14 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-HDLzxm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:27:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:27:14 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-UHE9f1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:27:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:27:14 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-IeSZ65-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:27:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:27:14 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-rAPDZL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:27:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:27:14 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-RZcLQy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:27:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:27:14 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-o6PYa_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:27:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:27:15 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-94zY84-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:27:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:27:15 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-eoi8aY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:27:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:27:15 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-pqtsuH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:27:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:27:15 INFO - Running setup.py install for manifestparser 09:27:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:27:15 INFO - Running setup.py install for mozcrash 09:27:15 INFO - Running setup.py install for mozdebug 09:27:15 INFO - Running setup.py install for mozdevice 09:27:15 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:27:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:27:15 INFO - Running setup.py install for mozfile 09:27:16 INFO - Running setup.py install for mozhttpd 09:27:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:27:16 INFO - Running setup.py install for mozinfo 09:27:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:27:16 INFO - Running setup.py install for mozInstall 09:27:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:27:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:27:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:27:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:27:16 INFO - Running setup.py install for mozleak 09:27:16 INFO - Running setup.py install for mozlog 09:27:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:27:16 INFO - Running setup.py install for moznetwork 09:27:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:27:16 INFO - Running setup.py install for mozprocess 09:27:17 INFO - Running setup.py install for mozprofile 09:27:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:27:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:27:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:27:17 INFO - Running setup.py install for mozrunner 09:27:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:27:17 INFO - Running setup.py install for mozscreenshot 09:27:17 INFO - Running setup.py install for moztest 09:27:17 INFO - Running setup.py install for mozversion 09:27:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:27:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:27:17 INFO - Cleaning up... 09:27:17 INFO - Return code: 0 09:27:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:27:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:27:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:27:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:27:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:27:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:27:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:27:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f1c2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f138570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7e0cc3340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10efd6d30>, '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 0x10ee3cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10efceb20>, '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.HXOxP4PXz2/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.3HzMKOHxr8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/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 09:27:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:27:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:27:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HXOxP4PXz2/Render', 09:27:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:27:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:27:17 INFO - 'HOME': '/Users/cltbld', 09:27:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:27:17 INFO - 'LOGNAME': 'cltbld', 09:27:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:27:17 INFO - 'MOZ_NO_REMOTE': '1', 09:27:17 INFO - 'NO_EM_RESTART': '1', 09:27:17 INFO - 'PAGER': '/bin/cat', 09:27:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:27:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:27:17 INFO - 'PWD': '/builds/slave/test', 09:27:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:27:17 INFO - 'SHELL': '/bin/bash', 09:27:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3HzMKOHxr8/Listeners', 09:27:17 INFO - 'TMPDIR': '/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/', 09:27:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:27:17 INFO - 'USER': 'cltbld', 09:27:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:27:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:27:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:27:17 INFO - 'XPC_FLAGS': '0x0', 09:27:17 INFO - 'XPC_SERVICE_NAME': '0', 09:27:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:27:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:27:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:27:18 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-GBTlxO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:27:18 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)) 09:27:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:27:18 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-TdJ0ng-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:27:18 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)) 09:27:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:27:18 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-fk4mq_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:27:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:27:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:27:18 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-cVviKb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:27:18 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)) 09:27:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:27:18 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-Pk8DgA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:27:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:27:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:27:18 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-OhLIPy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:27:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:27:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:27:18 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-X0VBGK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:27:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:27:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:27:18 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-X98raw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:27:19 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)) 09:27:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:27:19 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-BXpHxN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:27:19 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)) 09:27:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:27:19 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-T_5RxN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:27:19 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)) 09:27:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:27:19 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-0khwVe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:27:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:27:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:27:19 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-V2n4Yb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:27:19 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)) 09:27:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:27:19 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-rpoAMq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:27:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:27:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:27:19 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-BUbv3A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:27:19 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)) 09:27:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:27:19 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-w14bPR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:27:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:27:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:27:19 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-9LitaC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:27:19 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)) 09:27:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:27:19 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-sVwjOG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:27:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:27:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:27:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:27:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:27:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:27:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:27:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:27:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:27:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:27:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:27:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:27:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:27:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:27:22 INFO - Downloading blessings-1.6.tar.gz 09:27:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:27:22 INFO - Installing collected packages: blessings 09:27:22 INFO - Running setup.py install for blessings 09:27:22 INFO - Successfully installed blessings 09:27:22 INFO - Cleaning up... 09:27:22 INFO - Return code: 0 09:27:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:27:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:27:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:27:23 INFO - Reading from file tmpfile_stdout 09:27:23 INFO - Current package versions: 09:27:23 INFO - blessings == 1.6 09:27:23 INFO - blobuploader == 1.2.4 09:27:23 INFO - docopt == 0.6.1 09:27:23 INFO - functools32 == 3.2.3-2 09:27:23 INFO - jsonschema == 2.5.1 09:27:23 INFO - manifestparser == 1.1 09:27:23 INFO - mozInstall == 1.12 09:27:23 INFO - mozcrash == 0.17 09:27:23 INFO - mozdebug == 0.1 09:27:23 INFO - mozdevice == 0.48 09:27:23 INFO - mozfile == 1.2 09:27:23 INFO - mozhttpd == 0.7 09:27:23 INFO - mozinfo == 0.9 09:27:23 INFO - mozleak == 0.1 09:27:23 INFO - mozlog == 3.4 09:27:23 INFO - moznetwork == 0.27 09:27:23 INFO - mozprocess == 0.23 09:27:23 INFO - mozprofile == 0.28 09:27:23 INFO - mozrunner == 6.12 09:27:23 INFO - mozscreenshot == 0.1 09:27:23 INFO - mozsystemmonitor == 0.3 09:27:23 INFO - moztest == 0.7 09:27:23 INFO - mozversion == 1.4 09:27:23 INFO - psutil == 3.1.1 09:27:23 INFO - requests == 1.2.3 09:27:23 INFO - wsgiref == 0.1.2 09:27:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:27:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:27:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:27:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:27:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:27:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:27:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:27:23 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 0x10f1c2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f138570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7e0cc3340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10efd6d30>, '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 0x10ee3cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10efceb20>, '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.HXOxP4PXz2/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.3HzMKOHxr8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/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 09:27:23 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 09:27:23 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 09:27:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HXOxP4PXz2/Render', 09:27:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:27:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:27:23 INFO - 'HOME': '/Users/cltbld', 09:27:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:27:23 INFO - 'LOGNAME': 'cltbld', 09:27:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:27:23 INFO - 'MOZ_NO_REMOTE': '1', 09:27:23 INFO - 'NO_EM_RESTART': '1', 09:27:23 INFO - 'PAGER': '/bin/cat', 09:27:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:27:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:27:23 INFO - 'PWD': '/builds/slave/test', 09:27:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:27:23 INFO - 'SHELL': '/bin/bash', 09:27:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3HzMKOHxr8/Listeners', 09:27:23 INFO - 'TMPDIR': '/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/', 09:27:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:27:23 INFO - 'USER': 'cltbld', 09:27:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:27:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:27:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:27:23 INFO - 'XPC_FLAGS': '0x0', 09:27:23 INFO - 'XPC_SERVICE_NAME': '0', 09:27:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:27:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:27:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:27:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:27:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:27:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:27:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:27:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:27:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:27:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:27:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 09:27:23 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:27:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:27:23 INFO - Cleaning up... 09:27:23 INFO - Return code: 0 09:27:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:27:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:27:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:27:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:27:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:27:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:27:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:27:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f1c2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f138570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7e0cc3340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10efd6d30>, '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 0x10ee3cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10efceb20>, '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.HXOxP4PXz2/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.3HzMKOHxr8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/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 09:27:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:27:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:27:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HXOxP4PXz2/Render', 09:27:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:27:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:27:23 INFO - 'HOME': '/Users/cltbld', 09:27:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:27:23 INFO - 'LOGNAME': 'cltbld', 09:27:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:27:23 INFO - 'MOZ_NO_REMOTE': '1', 09:27:23 INFO - 'NO_EM_RESTART': '1', 09:27:23 INFO - 'PAGER': '/bin/cat', 09:27:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:27:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:27:23 INFO - 'PWD': '/builds/slave/test', 09:27:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:27:23 INFO - 'SHELL': '/bin/bash', 09:27:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3HzMKOHxr8/Listeners', 09:27:23 INFO - 'TMPDIR': '/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/', 09:27:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:27:23 INFO - 'USER': 'cltbld', 09:27:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:27:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:27:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:27:23 INFO - 'XPC_FLAGS': '0x0', 09:27:23 INFO - 'XPC_SERVICE_NAME': '0', 09:27:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:27:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:27:23 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:27:23 INFO - Cleaning up... 09:27:23 INFO - Return code: 0 09:27:23 INFO - Running post-action listener: _resource_record_post_action 09:27:23 INFO - Running post-action listener: _start_resource_monitoring 09:27:23 INFO - Starting resource monitoring. 09:27:23 INFO - [mozharness: 2016-11-03 16:27:23.647528Z] Finished create-virtualenv step (success) 09:27:23 INFO - [mozharness: 2016-11-03 16:27:23.648498Z] Running install step. 09:27:23 INFO - Running pre-action listener: _resource_record_pre_action 09:27:23 INFO - Running main action method: install 09:27:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:27:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:27:23 INFO - Reading from file tmpfile_stdout 09:27:23 INFO - Detecting whether we're running mozinstall >=1.0... 09:27:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:27:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:27:24 INFO - Reading from file tmpfile_stdout 09:27:24 INFO - Output received: 09:27:24 INFO - Usage: mozinstall [options] installer 09:27:24 INFO - Options: 09:27:24 INFO - -h, --help show this help message and exit 09:27:24 INFO - -d DEST, --destination=DEST 09:27:24 INFO - Directory to install application into. [default: 09:27:24 INFO - "/builds/slave/test"] 09:27:24 INFO - --app=APP Application being installed. [default: firefox] 09:27:24 INFO - mkdir: /builds/slave/test/build/application 09:27:24 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'] 09:27:24 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 09:27:55 INFO - Reading from file tmpfile_stdout 09:27:55 INFO - Output received: 09:27:55 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 09:27:55 INFO - Running post-action listener: _resource_record_post_action 09:27:55 INFO - [mozharness: 2016-11-03 16:27:55.988396Z] Finished install step (success) 09:27:55 INFO - [mozharness: 2016-11-03 16:27:55.988576Z] Running run-tests step. 09:27:55 INFO - Running pre-action listener: _resource_record_pre_action 09:27:55 INFO - Running main action method: run_tests 09:27:55 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:27:55 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:27:55 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:27:56 INFO - 2016-11-03 09:27:56.000 screenresolution[1924:14550] starting screenresolution argv=screenresolution get 09:27:56 INFO - 2016-11-03 09:27:56.003 screenresolution[1924:14550] Display 0: 1600x1200x32@60 09:27:56 INFO - 2016-11-03 09:27:56.009 screenresolution[1925:14553] starting screenresolution argv=screenresolution list 09:27:56 INFO - Available Modes on Display 0 09:27:56 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:27:56 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:27:56 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:27:56 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:27:56 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:27:56 INFO - Intel Iris: 09:27:56 INFO - Chipset Model: Intel Iris 09:27:56 INFO - Type: GPU 09:27:56 INFO - Bus: Built-In 09:27:56 INFO - VRAM (Dynamic, Max): 1536 MB 09:27:56 INFO - Vendor: Intel (0x8086) 09:27:56 INFO - Device ID: 0x0a2e 09:27:56 INFO - Revision ID: 0x0009 09:27:56 INFO - Displays: 09:27:56 INFO - Display: 09:27:56 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:27:56 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:27:56 INFO - Display Serial Number: 1600x1200 60 09:27:56 INFO - Main Display: Yes 09:27:56 INFO - Mirror: Off 09:27:56 INFO - Online: Yes 09:27:56 INFO - Rotation: Supported 09:27:56 INFO - Return code: 0 09:27:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:27:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:27:56 INFO - Python 2.7.3 09:27:56 INFO - Return code: 0 09:27:56 INFO - grabbing minidump binary from tooltool 09:27:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:27:56 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 0x10efd6d30>, '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 0x10ee3cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10efceb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:27:56 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 09:27:56 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 09:27:56 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 09:27:56 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:27:56 INFO - Return code: 0 09:27:56 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:27:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:27:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:27:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:27:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:27:56 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/Ih8HRY3cQJ60r4IrY3xr0Q/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0359', '--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 09:27:56 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/Ih8HRY3cQJ60r4IrY3xr0Q/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0359 --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 09:27:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HXOxP4PXz2/Render', 09:27:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:27:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:27:56 INFO - 'HOME': '/Users/cltbld', 09:27:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:27:56 INFO - 'LOGNAME': 'cltbld', 09:27:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:27:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:27:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:27:56 INFO - 'MOZ_NO_REMOTE': '1', 09:27:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:27:56 INFO - 'NO_EM_RESTART': '1', 09:27:56 INFO - 'PAGER': '/bin/cat', 09:27:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:27:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:27:56 INFO - 'PWD': '/builds/slave/test', 09:27:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:27:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:27:56 INFO - 'SHELL': '/bin/bash', 09:27:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3HzMKOHxr8/Listeners', 09:27:56 INFO - 'TMPDIR': '/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/', 09:27:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:27:56 INFO - 'USER': 'cltbld', 09:27:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:27:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:27:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:27:56 INFO - 'XPC_FLAGS': '0x0', 09:27:56 INFO - 'XPC_SERVICE_NAME': '0', 09:27:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:27:56 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/Ih8HRY3cQJ60r4IrY3xr0Q/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0359', '--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 09:27:56 INFO - mozversion application_buildid: 20161103062923 09:27:56 INFO - mozversion application_changeset: c31d95b2a3cd435ffd4808c5f939fe5c9c1a7648 09:27:56 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:27:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:27:56 INFO - mozversion application_name: Firefox 09:27:56 INFO - mozversion application_remotingname: firefox-dev 09:27:56 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:27:56 INFO - mozversion application_vendor: Mozilla 09:27:56 INFO - mozversion application_version: 51.0a2 09:27:56 INFO - mozversion platform_buildid: 20161103062923 09:27:56 INFO - mozversion platform_changeset: c31d95b2a3cd435ffd4808c5f939fe5c9c1a7648 09:27:56 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:27:56 INFO - mozversion platform_version: 51.0a2 09:27:56 INFO - using testdate: 1478190476 09:27:56 INFO - actual date: 1478190476 09:27:56 INFO - starting webserver on 'localhost:50912' 09:27:56 INFO - SUITE-START | Running 2 tests 09:27:56 INFO - TEST-START | dromaeo_css 09:27:56 INFO - operating with platform_type : mac_ 09:27:56 INFO - Initialising browser for dromaeo_css test... 09:27:56 INFO - TEST-INFO | started process 1935 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/tmp2nKNbw/profile http://localhost:50912/getInfo.html) 09:27:58 INFO - PROCESS | 1935 | __metrics Screen width/height:1600/1200 09:27:58 INFO - PROCESS | 1935 | colorDepth:24 09:27:58 INFO - PROCESS | 1935 | Browser inner width/height: 1024/689 09:27:58 INFO - PROCESS | 1935 | __metrics 09:27:58 INFO - PROCESS | 1935 | 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" 09:27:58 INFO - PROCESS | 1935 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:27:59 INFO - TEST-INFO | 1935: exit 0 09:27:59 INFO - Browser initialized. 09:27:59 INFO - Running cycle 1/1 for dromaeo_css test... 09:27:59 INFO - TEST-INFO | started process 1937 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/tmp2nKNbw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:28:11 INFO - PROCESS | 1937 | RSS: Main: 219742208 09:28:11 INFO - PROCESS | 1937 | 09:29:02 INFO - PROCESS | 1937 | 1478190542820 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] 09:31:15 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:50912/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50912/tests/dromaeo/cssquery-ext.html) 09:31:16 INFO - PROCESS | 1937 | RSS: Main: 324476928 09:31:16 INFO - PROCESS | 1937 | 09:34:19 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:50912/tests/dromaeo/cssquery-ext.html (next: http://localhost:50912/tests/dromaeo/cssquery-jquery.html) 09:34:20 INFO - PROCESS | 1937 | RSS: Main: 351277056 09:34:20 INFO - PROCESS | 1937 | 09:37:22 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:50912/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50912/tests/dromaeo/cssquery-mootools.html) 09:37:22 INFO - PROCESS | 1937 | RSS: Main: 324583424 09:37:22 INFO - PROCESS | 1937 | 09:40:25 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:50912/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50912/tests/dromaeo/cssquery-prototype.html) 09:40:25 INFO - PROCESS | 1937 | RSS: Main: 340090880 09:40:25 INFO - PROCESS | 1937 | 09:43:29 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:50912/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50912/tests/dromaeo/cssquery-yui.html) 09:43:29 INFO - PROCESS | 1937 | RSS: Main: 308932608 09:43:29 INFO - PROCESS | 1937 | 09:46:32 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:50912/tests/dromaeo/cssquery-yui.html (next: http://localhost:50912/tests/dromaeo/cssquery-dojo.html) 09:46:33 INFO - PROCESS | 1937 | RSS: Main: 362033152 09:46:33 INFO - PROCESS | 1937 | 09:46:33 INFO - PROCESS | 1937 | __start_tp_report 09:46:33 INFO - PROCESS | 1937 | _x_x_mozilla_page_load 09:46:33 INFO - PROCESS | 1937 | _x_x_mozilla_page_load_details 09:46:33 INFO - PROCESS | 1937 | |i|pagename|runs| 09:46:33 INFO - PROCESS | 1937 | |0;dojo.html;3248.3990461764574;3263.249452625896;3277.066036179691;3289.2928020475624;3328.8335583220833;5613.831585052445;5679.7160141992945;5693.572982026344;5703.800366987151;5707.115397113449;5618.550515958724;5693.971530142344;5713.771449142039;5717.142428635707;5726.885462290752;5155.5360017598405;5159.793608255665;5162.380514338284;5208.427073021964;5214.8696282592855;5118.4113826909825;5125.436202017775;5154.561862241714;5275.815346462875;5315;5217.608679349045;5239.423663397023;5242.161254199329;5242.6330156889035;5257.76340064698;5232.555232805216;5234.7120908350025;5235.712035838027;5239.3712754469325;5244.68531888086;5077.314562534048;5188.481151884781;5199.506046925536;5208.166693329087;5232.8691782705355;5642.181883626851;5654.264945557093;5675.829725108253;5702.971485142589;5705.486506214419;6142.815715528542;6154.984427569446;6225;6241.812745617639;6245.156903818017;4906.803727850882;6126.823043872694;6276.403741644536;6281.654509002003;6303;5666.46168613981;5685.976524225596;5692.203091567184;5700.486956173964;5744;5219;5839.5036421904615;6200.286966998763;6208.255009398901;6216.160818289563;6163.445289923929;6165.568410211332;6172.321044685081;6173.166622505904;6185.8453538661;6092.390760923872;6107.454994951028;6126.366913828976;6135.134730314741;6192.318844927055;6122.448979591769;6189.133521307021;6190.628562286277;6193.473554747897;6201.317855035943;6191.9690401547705;6214.8135555933395;6225.221847269091;6228.937710622927;6237.033259844731;4819.662623616383;4862.6839255448285;4867.805287788519;4875.536824001714;4934.284528743312;3681.7975011374097;4285.892852678708;4316.460442444694;4335.328024156261;4345.630621397217;5572.60991730575;5583.497485226268;5588.385277619459;5610.214569960209;5629.971850140805;5095.184770436712;6107.236595425572;6131.6213479391645;6154.107654390088;6156.753729850845;5624;5630.60585758993;5652.717364131777;5725.2843394575675;5811.56413268998;5385.73071346439;5396.379416367168;5397.109476936262;5402.37872644643;5410.458954104558;6257.687115644108;6273.749050037947;6278.372162783685;6280.497560195174;6282.842928926813;6136.478399336106;6136.693165341626;6151.954167791576;6168.876622467616;6214.9689251553455;6239.407256310643;6250.4374606285655;6252.562320637512;6253.593516421418;6273.592216505913;6102.481289090477;6130.969345153246;6153.661548614869;6168.228971378578;6179.443850053517;5385.0037743017665;6101.084837274444;6113.633182009094;6148.938510615016;6153.969230153821;5923.378045305181;5962.433568810956;6069.484093852072;6094.664793436404;6117.388261174025;6073.908891366721;6077.939220607737;6081.604695694766;6092.786752463642;6099.451049405575;5749.993751093458;5817.5345972321265;5864.091065884794;5919.852003699942;5923.229980102559;5997.220361352996;6002.3097343804275;6044.90932636002;6119.510439164945;6144.969275153596;5909.940900591111;5919.7040147991565;5933.228680271537;5940.702964851654;5952.5833191676165 09:46:33 INFO - PROCESS | 1937 | |1;ext.html;437.481584322578;481.79070532962277;517.9093658609744;520.0846510142148;542.5713686187912;21662.783372166272;31346.686533134663;39918.40122398163;41025.76922692324;41404.792976035074;42376.788116059455;42732.786336068275;42768;42797;42855.78572107143;8286.875696864538;9919.404835709844;9926.057024582653;9930.65242716505;9933.00669933008;8778.122187781235;8978;9664.371815831948;11872.22830516018;12102.757944841098;12151.27092374456;12200.755984880341;12241.693957651041;12243.510259589606;12250.93874530626;12186.939065304661;12229.633111006684;12235.510579576807;12236.694082647917;12260.325682087527;8450.535220562866;8668.696595619185;11746.060315174765;12078.15452918296;12106.757864842653;34662.48006279908;37719.05702357436;39187.608123918966;39550.406743898864;39557;3290.3912776136253;3335.8665653373837;3371.511130886008;3610.765300255475;3988.3020471417385;29166.562501562494;29436.852815735783;30813.383732325226;31374.215644608837;32185.83907080473;3305.752068594841;3321.0701003718996;3328.0182346207926;3334.283129127225;3356.8992930212135;527175;541615;541782.2910885459;542536;542830;67263;68066.319336806;68076;68143.65928170328;68180.6590967042;70581;71114;71176.64411677909;71202;71354.64322678353;17058.48824535266;17650.470485885446;17692.026938518506;17716.734248986275;17721.822781772018;11992.940035299767;13196.406161722745;13339.132956357806;13388.598342049754;13400.865991339962;16628.916855415646;17302.394416195373;20272.797272027386;20359.8982005092;20896.791032089484;8305.8338833223;8354.624041918129;8363.832723345498;8368.916310836814;8443.873341899876;864.9524276164872;913.5930666773228;962.259060523393;1016.3850870223556;1114.5597488991964;29952.550711739343;30008.849955750517;30167;30244.697553024187;30324.84837575798;1031.9587216511406;1066.9573217071386;1088.5373716170755;1164.941752912351;1173.5892437646755;14857.777133343008;15112.094659928054;15599.064056156667;15840.60398490047;16010.199490025452;712886;717076;718226;719465;720385;57284.71357643185;57776;57841.710791445774;57923;57951.13073303904;1237.641084085623;1279.923204607708;1354.3769865861814;1376.779715245556;1406.648337915521;29774.8511257451;31489.685103148677;31576.052718418483;31577.684223158394;31954.520682189323;48757;49330.26004609862;49338.75330623324;49372;49464;533530;536180;537055;538449;538955;20930;27322.726772732018;27450.725492745616;28224.71775282303;42875.928101797705;47205.76397117993;47235;47588.81027974328;47612.047759045316;47802.521974779804;38058.429123562615;39258.411123833735;40659.796701016305;41215.587844122376;41243.1751364977;38996.61003390043;39141.608583913796;39719.40420893747;40172.799136004134;40282;38393.61606383901;38534.61465385422;38731.2253754929;38983.22033559256;39053.2189356217;33021.009369718944;34036;34705.82647086748;34712.479312810836;35296.64703353036;24642.753572464764;25953.870230648725;26155.215343539723;26725.19824405271;26786.464270714867 09:46:33 INFO - PROCESS | 1937 | |2;jquery.html;355.80075157911557;374.42151875352596;375.66753423220445;386.5960071725047;407.4947065638607;15021.62445938852;15635.921820390897;17307.04811235383;20553.69169462459;20727.06728197231;19490.415287541397;20648.896755516238;21307.25424610139;21393.0373133209;21483.355499335004;5931.110333449974;5985.610935289204;6136.509079273647;6237.719302631393;6238.812835614916;4232.936505952413;6083.574149809515;6188.288346840126;6194.721237544321;6195.5663103582765;4438.822447102112;6573.638449885254;6863.828404289883;6896.137982752156;6990.5456145350645;5253;5908.586398952075;6252.687365631746;6951.930480695204;6993.720251189946;6127.20346354971;6139;6143.907841382383;6145.539084568631;6145.969270153665;13383.464661413533;13487.325633718374;13699.178049317074;13835.03154779166;13846.10000349974;2170.511634882155;2261.8416710830247;2396.928092157238;2649.713288456744;2861.470627933839;10169.389836609827;10267.486625668687;10674;10702.839457408145;10708.1433485321;1755.7893052833742;1985.8808471491757;1988.8906110163934;1991.8804871707598;2003.7294965179806;122325;126986;129185;131320.06039818822;133025.66974330327;7665.463417560717;8211.95894020538;10138.442385668712;10205.234607404474;11672.649820505398;12448.439820208112;12530.686732831753;12544.937275313747;12558.372081395893;12561.183523070971;8262.256396924186;8347.207015333533;8367.330613550901;8373.623186956602;8516.318694504425;8794.164554367326;8795.51624660637;8812.515311657791;8947.239484643747;8959.776005599912;3965.20695860829;3966.8809935701975;3975.801209939549;4026.033751899523;4040.8989775255855;1662.5760431089996;1932.439592518182;1974.3385965701364;1974.792646772097;2014.113789932425;826.277007618334;869.1959937058323;912.4206129107931;947.4982153287117;993.0714781679153;21854.125834966424;22179.891005449663;22183.889080554494;22271.777282227293;22318;931.0689310689311;937.5373223456397;942.604106275366;974.1573538888811;1002.7142264454595;10826.458677066115;11667.59163429276;11686.065114790796;11703.707407314885;11710.00464960488;591172;612331;618149;618732;636154;134871;140640;141866.87199692012;143870.2806485961;144180.27909860385;898.60910503931;957.5260246178186;999.14073896449;1026.3226270661328;1034.6016783538391;19541.316053938044;20470.897645511675;20511.38465846027;20563;20739.585208296052;54999.17501237565;56089.43910560842;57236;57299;57461.42538574728;83116.58441707752;84045.15954840374;84925.57537212274;85447.5727621358;88202.67695984694;8212.58937053133;8223.54770487629;8363.247307742333;8466.576671166295;8745.737627871174;12527.686807829512;13339;13473.46106155782;14038.929805350908;14207.715845683235;9710.368826026286;11580.36308003068;11694.356810375511;12048.578299759816;12091.697707557381;11559.36423496682;11621;11629.418529073682;11835.408229588314;12034.217775844892;11656.417179140839;11905.226160299553;11965.042796576427;12094.185872119253;12120.636380908587;7141.357277845019;8236.629351679308;8388.077311495608;8390.664373424994;8635.352348573757;8903.554822258991;9453.763655908657;11714.589989350332;12080.879191207976;12122.696932576757 09:46:33 INFO - PROCESS | 1937 | |3;mootools.html;1340.269553093564;1499.7375459294624;1534.2635534943227;1733.4106403822705;1919.7408349872762;7896.723614673488;8472.406931514797;8621.52581608012;8926.553672316391;8939.374243802937;8599.656013759442;8931.106889311082;8936.017038125801;8942.731718048453;8948.28413726902;2388.6417037444394;2446.425090103824;2447.36368544178;2449.0448724997264;2453.987730061347;2402.3633737059604;2429.708434987804;2446.7430919753347;2450.4608986023136;2456.152627343564;2202.185191479155;2361.7047869016374;2405.855648661086;2417.476989496615;2425.4785221177444;2386.916457923982;2407.7471865454136;2415.311636183679;2420.3828023853803;2430.769076937688;2324.9883750581307;2409.9879500602383;2411.6623672685837;2413.3363325085566;2417.589009868309;7954.125046244909;8113.8782918256275;8921.01868794432;9008.684696035672;9010.098990101003;4935.901281974377;5081.339425874649;5105.923411148836;5110.10573149701;5303.681779093266;3613.7470377073614;3625.6947498900377;3664.285464334456;3713.1459764254373;3721.2557488502407;959.6065613098596;1096.1942971915635;1109.1958330210614;1120.0479592346521;1139.9512448547273;11767.058635309155;11836.644900652995;11910.225835320676;11939.701507462296;11940.641780746591;4175.227582897173;4220.164228560586;4701.7414042228;4749.145153872336;4954.232094025359;10223.284370094021;10223.335483193569;10230.488475576192;10240.948795255976;10246.129079028216;5471;5475.72621368938;5476.096444086681;5478.643888147258;5490.313710786152;4784.354112194878;4916.385451818523;4957.405111386656;4995.675281106716;5000;3834.827432765532;3854.3447613905705;3898.1034362096875;3940.605939406094;3955.7033222508426;1194.3371428856894;1196.6948428150765;1200.7598480303975;1204.8433703618473;1208.9214201076902;744.6351287869013;848.8896443462311;900.8333458310234;912.9132732390412;930.1721467893581;5662.85842853932;5777.913331300034;5805.129230615442;5959.73181206838;6095.1771510845465;863.5293764898146;911.1253196930888;913.917747402737;950.1591091883595;961.7547525381123;3828.272628200633;3900.9609903901164;3909.237698648793;3933.488646475997;3954.169624378855;10756.085732712807;10977.670669879917;11021.83467247992;11035.337879727242;11037.227394082498;10969.506372213269;10973.286736362112;10980.725481862857;10980.890191098146;10984.176186785864;7847;8189.754307370788;8215.630296636546;8269.46248493858;8307.210814972568;5897.941020589911;5939.376365481562;6005.978983572716;6012.819615411545;6101.389861013863;9701.951490242785;9942.204623630238;10237.181025517792;10239.180865530889;10240.334378265388;10208.540615672164;10334.586616535255;10349.689509314732;10393.168546516412;10504.632337868137;7511;7655.655495502604;7778.766637000899;7781.5331080135375;7787.260210280015;8314.501129932223;8322.250997410261;8394.832103358021;8411.242988131098;8411.915880841114;7465;7469.701211951461;7484.663190156565;7489.28851759082;7529.962350188214;7300.415966722543;7378.889316660147;7403.629818509161;7409.222031686595;7438.144613369532;6918.827029324106;7031.261717519586;7032.226455090038;7034.015237866601;7057.964710176417;4804.25534042224;4864.8324402143935;4948.134076536519;4979.377577802775;5048.59611231108;4879.512048795092;4919.671757916463;4985.227289770091;5045.672031317952;5063.367079115111 09:46:33 INFO - PROCESS | 1937 | |4;prototype.html;286.1159018632425;301.93659331540374;304.96645369009406;312.90769223079195;314.3979279679414;4421.66837487189;4505.053938672874;5217.287010754406;5304.787808487661;5388.784448622056;4514.029483661012;4567;4589.908201835961;4892.217245240762;5224.8693782655355;3814.9427758583643;3878.3600705883496;4006.4991876015497;4171.520275168349;4172.705012243269;4091.7340372875815;4093.7339072960162;4141.896452588694;4143.482064741907;4154.273002224613;3839.9616003840024;3973.7417067890638;4083.0404854859084;4086.121483880965;4131.338985762279;2898.2029941765973;3463.3765922134007;3553.5558055243096;3994.2610617035652;4010.137820368635;3506.66686664769;3516.7010804081683;3518.313928783888;3522.771019883725;3548.627394123606;4088.4480595119576;4810.687305325143;4910.680805747651;5265.6577322474295;5301.879248300672;4112.712110152291;4466.927937295026;4612.331211974279;4649.558291962258;4682.765861706901;4575.931361029588;4602.286645569942;5711.8000869969765;5721.0846264597885;5755.510781583571;3417.9316413671836;3869.806509674533;3872.380419132953;3879.553851307079;3887.844486220548;5669;5670.894175635753;5675.659460432346;5749;5972.611780234271;3440.4323286657423;3921.960680419691;3924.411338299221;3924.9018774530296;3927.6857851371824;3966.690991972642;3977.423273625308;4001.9799901000893;4003.2577684285775;4009.4363198352667;3668.991027467468;4489.932651010237;4671.43942726875;4685.156671799041;4728.101660684528;4688.484266730657;4779.95220047802;5399.352077750695;5658.264425624642;5779.2775903012125;1182.6984119049587;1294.9287789171497;1356.4913157565913;1357.0907491980397;1363.6931690369588;667.8063361625171;697.8115908704723;816.2408959667566;819.6885183630302;834.6953362022819;4301.010767523487;4390.275604525217;4525.683202175882;4548.795304211319;4569.451665800058;4175.6868234881895;4891.877703057452;4900.897298107969;4922.704637721748;4965.013994402268;4309.586631486378;4485.46174459067;4498.672891496951;4530.864074077783;4551.316013075183;2449.595816690262;2595.454954459547;2599.8291426658575;2604.479104179172;2618.751218634227;4875.634327425386;5076.771545280471;5077.974610126926;5082.74586270685;5108.821191258288;4330.783460826946;4386.210482113251;4784.30627559002;4978.551930326215;5005.199168133081;3739.233457141334;4500.804428855484;4613.515580863961;5087.287779710918;5103.464136265638;4132.016632016589;4644.744539050384;4677.017826256388;4933.851984440473;4946.554810067111;4268.893277668083;4629.629629629554;4782.2826576012485;4847.2729090636685;4850.865619127714;4668.206404911241;4717.292406139107;5072.264521644414;5087.618428617794;5111.361079865017;3252.3818326247597;3409.4374428219066;3421.5894092709036;3427.2802711430877;3430.811305378228;4280.143971205709;4744.346852923299;4746.501617330131;4880.1934491097;5543.778248870161;4802.247179779425;5246.868828279324;5635.8591035224445;5651.406602306699;5666.773329066956;5666.405027472221;5667.744951477111;5670.574706896917;5675.432456754456;5695.288088988877;5250.422453530185;5546.310039630695;5580.2466666999435;5593.580481463825;5685.8862822742485;5022.564056432554;5291.76187071575;5750.25246717924;5763.33721622002;5777.653340799566;4500.9099818004115;5463.617546771688;5628.296462942132;5656.490915817596;5705.515031222392 09:46:33 INFO - PROCESS | 1937 | |5;yui.html;647.3106141958814;659.5119611487497;679.7281087564974;770.4953255617565;855.9786005349862;15299.54101376959;16260.349586016546;16266.186690665478;16280.83719162808;16327.510174694764;13338.399772010258;14420.49528266511;14564.854351456483;14705.117692938431;15514.922425387886;826.9627866745981;868.3096937934357;872.7818045488627;874.470945078228;880.6521424037502;867.2541614211773;871.6992637540038;872.5593575244525;876;878.6353663229752;908.2824568590805;909.1908201700492;913.1416468519603;914.0676509959837;916.4501299220448;902.7743064233941;904.8326059678981;905.5879574793453;907.6324088744036;909.9363044586881;679.7111227728245;679.7145199016425;681.2608319972835;682.0621645237798;690.9550879192836;14818.851811481854;15211.61970950724;15256.618584535365;15276.38894444221;15421;13800.516981905585;14464.927675361661;14688.926555367261;14738.852611473856;14929;10475.214358923035;11391.829122563167;11582.247153934968;11815.350155741431;12015.399230038463;3253.902382928516;3809.9238015239816;3819.9809000955097;3827.827747751358;3842.4428457873732;70499.64750176268;78545;82448;118446;120208;10469.005444482762;10668.253222274521;11072.833907491395;11095.778084438427;11237.3257604544;14965.551033469013;17786.932784033;22024.008919598655;22468;22472.887635561718;7703.807404814925;7931.920680793233;8028.919710802934;8175.509469431734;8239.052508961426;4398.428204333416;4512.593866552026;4578.725276483422;4586.518415566385;4674.883127921761;3520.383932811799;3670.33933891902;3680.300742858848;3683.189698266377;3692.095436618046;648.4271663136154;671.405805861806;678.0947435174098;684.674779479753;687.7558466744334;636.7803107927757;662.8243515468405;680.2823021712043;690.2407351912856;696.3871792822284;8995.460272383678;9742;9788.755281118029;9825.852612210823;9910.653127140515;555.8804856955774;580.4166812353558;668.0680450771147;681.9352161544646;688.7004153193377;4374.059577190919;4767.809287628525;4771.5228477152;4786.64100192487;4872.123017856819;131633;149303;168621.31378686056;173463;176710;89255;108089;109509.90490094997;111107;112305;89483;96538;98343;100011;100569;9599.088086631758;10017.499125043865;10019.899801001897;10042.949785251027;10163.28856980034;57709.13436298375;58078;58528.707356462946;59435.70282148562;59687;81204;85588;85655.57172214099;86551;86597;12562.120651554304;12759.93620031894;12781.8082728761;12891.48434062627;13015.544455943997;13871.167729936236;14595.416183352547;14794.260286985824;16094.114823684342;16100;13162;14290.928545357207;14371.20958347301;14872.62818429548;14928.178950157411;13664;13984.681971398093;14085.08446950945;14240.359183836545;14548.908831837443;13889.513867014606;14016.018878678395;14207;14652.19412932299;14721.043132196373;11601.187916846078;11662.241954272946;11919.880801192225;12004.519819207135;12076.21504602198;9720.854187187339;11606.47770850297;11637.592684256011;11722.648320550397;11738.237014594024 09:46:33 INFO - PROCESS | 1937 | __end_tp_report 09:46:33 INFO - PROCESS | 1937 | __start_cc_report 09:46:33 INFO - PROCESS | 1937 | _x_x_mozilla_cycle_collect,1074 09:46:33 INFO - PROCESS | 1937 | __end_cc_report 09:46:33 INFO - PROCESS | 1937 | __startTimestamp1478191593186__endTimestamp 09:46:33 INFO - PROCESS | 1937 | 09:46:33 INFO - PROCESS | 1937 | ------- Summary: start ------- 09:46:33 INFO - PROCESS | 1937 | Number of tests: 6 09:46:33 INFO - PROCESS | 1937 | 09:46:33 INFO - PROCESS | 1937 | [#0] dojo.html Cycles:165 Average:5677.20 Median:5864.09 stddev:650.13 (11.1%) stddev-sans-first:623.58 09:46:33 INFO - PROCESS | 1937 | Values: 3248.4 3263.2 3277.1 3289.3 3328.8 5613.8 5679.7 5693.6 5703.8 5707.1 5618.6 5694.0 5713.8 5717.1 5726.9 5155.5 5159.8 5162.4 5208.4 5214.9 5118.4 5125.4 5154.6 5275.8 5315.0 5217.6 5239.4 5242.2 5242.6 5257.8 5232.6 5234.7 5235.7 5239.4 5244.7 5077.3 5188.5 5199.5 5208.2 5232.9 5642.2 5654.3 5675.8 5703.0 5705.5 6142.8 6155.0 6225.0 6241.8 6245.2 4906.8 6126.8 6276.4 6281.7 6303.0 5666.5 5686.0 5692.2 5700.5 5744.0 5219.0 5839.5 6200.3 6208.3 6216.2 6163.4 6165.6 6172.3 6173.2 6185.8 6092.4 6107.5 6126.4 6135.1 6192.3 6122.4 6189.1 6190.6 6193.5 6201.3 6192.0 6214.8 6225.2 6228.9 6237.0 4819.7 4862.7 4867.8 4875.5 4934.3 3681.8 4285.9 4316.5 4335.3 4345.6 5572.6 5583.5 5588.4 5610.2 5630.0 5095.2 6107.2 6131.6 6154.1 6156.8 5624.0 5630.6 5652.7 5725.3 5811.6 5385.7 5396.4 5397.1 5402.4 5410.5 6257.7 6273.7 6278.4 6280.5 6282.8 6136.5 6136.7 6152.0 6168.9 6215.0 6239.4 6250.4 6252.6 6253.6 6273.6 6102.5 6131.0 6153.7 6168.2 6179.4 5385.0 6101.1 6113.6 6148.9 6154.0 5923.4 5962.4 6069.5 6094.7 6117.4 6073.9 6077.9 6081.6 6092.8 6099.5 5750.0 5817.5 5864.1 5919.9 5923.2 5997.2 6002.3 6044.9 6119.5 6145.0 5909.9 5919.7 5933.2 5940.7 5952.6 09:46:33 INFO - PROCESS | 1937 | 09:46:33 INFO - PROCESS | 1937 | [#1] ext.html Cycles:180 Average:73405.73 Median:38464.12 stddev:161546.07 (420.0%) stddev-sans-first:161906.35 09:46:33 INFO - PROCESS | 1937 | Values: 437.5 481.8 517.9 520.1 542.6 21662.8 31346.7 39918.4 41025.8 41404.8 42376.8 42732.8 42768.0 42797.0 42855.8 8286.9 9919.4 9926.1 9930.7 9933.0 8778.1 8978.0 9664.4 11872.2 12102.8 12151.3 12200.8 12241.7 12243.5 12250.9 12186.9 12229.6 12235.5 12236.7 12260.3 8450.5 8668.7 11746.1 12078.2 12106.8 34662.5 37719.1 39187.6 39550.4 39557.0 3290.4 3335.9 3371.5 3610.8 3988.3 29166.6 29436.9 30813.4 31374.2 32185.8 3305.8 3321.1 3328.0 3334.3 3356.9 527175.0 541615.0 541782.3 542536.0 542830.0 67263.0 68066.3 68076.0 68143.7 68180.7 70581.0 71114.0 71176.6 71202.0 71354.6 17058.5 17650.5 17692.0 17716.7 17721.8 11992.9 13196.4 13339.1 13388.6 13400.9 16628.9 17302.4 20272.8 20359.9 20896.8 8305.8 8354.6 8363.8 8368.9 8443.9 865.0 913.6 962.3 1016.4 1114.6 29952.6 30008.8 30167.0 30244.7 30324.8 1032.0 1067.0 1088.5 1164.9 1173.6 14857.8 15112.1 15599.1 15840.6 16010.2 712886.0 717076.0 718226.0 719465.0 720385.0 57284.7 57776.0 57841.7 57923.0 57951.1 1237.6 1279.9 1354.4 1376.8 1406.6 29774.9 31489.7 31576.1 31577.7 31954.5 48757.0 49330.3 49338.8 49372.0 49464.0 533530.0 536180.0 537055.0 538449.0 538955.0 20930.0 27322.7 27450.7 28224.7 42875.9 47205.8 47235.0 47588.8 47612.0 47802.5 38058.4 39258.4 40659.8 41215.6 41243.2 38996.6 39141.6 39719.4 40172.8 40282.0 38393.6 38534.6 38731.2 38983.2 39053.2 33021.0 34036.0 34705.8 34712.5 35296.6 24642.8 25953.9 26155.2 26725.2 26786.5 09:46:33 INFO - PROCESS | 1937 | 09:46:33 INFO - PROCESS | 1937 | [#2] jquery.html Cycles:180 Average:36200.71 Median:2523.32 stddev:103314.43 (4094.4%) stddev-sans-first:103569.20 09:46:33 INFO - PROCESS | 1937 | Values: 355.8 374.4 375.7 386.6 407.5 15021.6 15635.9 17307.0 20553.7 20727.1 19490.4 20648.9 21307.3 21393.0 21483.4 5931.1 5985.6 6136.5 6237.7 6238.8 4232.9 6083.6 6188.3 6194.7 6195.6 4438.8 6573.6 6863.8 6896.1 6990.5 5253.0 5908.6 6252.7 6951.9 6993.7 6127.2 6139.0 6143.9 6145.5 6146.0 13383.5 13487.3 13699.2 13835.0 13846.1 2170.5 2261.8 2396.9 2649.7 2861.5 10169.4 10267.5 10674.0 10702.8 10708.1 1755.8 1985.9 1988.9 1991.9 2003.7 122325.0 126986.0 129185.0 131320.1 133025.7 7665.5 8212.0 10138.4 10205.2 11672.6 12448.4 12530.7 12544.9 12558.4 12561.2 8262.3 8347.2 8367.3 8373.6 8516.3 8794.2 8795.5 8812.5 8947.2 8959.8 3965.2 3966.9 3975.8 4026.0 4040.9 1662.6 1932.4 1974.3 1974.8 2014.1 826.3 869.2 912.4 947.5 993.1 21854.1 22179.9 22183.9 22271.8 22318.0 931.1 937.5 942.6 974.2 1002.7 10826.5 11667.6 11686.1 11703.7 11710.0 591172.0 612331.0 618149.0 618732.0 636154.0 134871.0 140640.0 141866.9 143870.3 144180.3 898.6 957.5 999.1 1026.3 1034.6 19541.3 20470.9 20511.4 20563.0 20739.6 54999.2 56089.4 57236.0 57299.0 57461.4 83116.6 84045.2 84925.6 85447.6 88202.7 8212.6 8223.5 8363.2 8466.6 8745.7 12527.7 13339.0 13473.5 14038.9 14207.7 9710.4 11580.4 11694.4 12048.6 12091.7 11559.4 11621.0 11629.4 11835.4 12034.2 11656.4 11905.2 11965.0 12094.2 12120.6 7141.4 8236.6 8388.1 8390.7 8635.4 8903.6 9453.8 11714.6 12080.9 12122.7 09:46:33 INFO - PROCESS | 1937 | 09:46:33 INFO - PROCESS | 1937 | [#3] mootools.html Cycles:180 Average:5769.09 Median:4918.03 stddev:3258.72 (66.3%) stddev-sans-first:3250.87 09:46:33 INFO - PROCESS | 1937 | Values: 1340.3 1499.7 1534.3 1733.4 1919.7 7896.7 8472.4 8621.5 8926.6 8939.4 8599.7 8931.1 8936.0 8942.7 8948.3 2388.6 2446.4 2447.4 2449.0 2454.0 2402.4 2429.7 2446.7 2450.5 2456.2 2202.2 2361.7 2405.9 2417.5 2425.5 2386.9 2407.7 2415.3 2420.4 2430.8 2325.0 2410.0 2411.7 2413.3 2417.6 7954.1 8113.9 8921.0 9008.7 9010.1 4935.9 5081.3 5105.9 5110.1 5303.7 3613.7 3625.7 3664.3 3713.1 3721.3 959.6 1096.2 1109.2 1120.0 1140.0 11767.1 11836.6 11910.2 11939.7 11940.6 4175.2 4220.2 4701.7 4749.1 4954.2 10223.3 10223.3 10230.5 10240.9 10246.1 5471.0 5475.7 5476.1 5478.6 5490.3 4784.4 4916.4 4957.4 4995.7 5000.0 3834.8 3854.3 3898.1 3940.6 3955.7 1194.3 1196.7 1200.8 1204.8 1208.9 744.6 848.9 900.8 912.9 930.2 5662.9 5777.9 5805.1 5959.7 6095.2 863.5 911.1 913.9 950.2 961.8 3828.3 3901.0 3909.2 3933.5 3954.2 10756.1 10977.7 11021.8 11035.3 11037.2 10969.5 10973.3 10980.7 10980.9 10984.2 7847.0 8189.8 8215.6 8269.5 8307.2 5897.9 5939.4 6006.0 6012.8 6101.4 9702.0 9942.2 10237.2 10239.2 10240.3 10208.5 10334.6 10349.7 10393.2 10504.6 7511.0 7655.7 7778.8 7781.5 7787.3 8314.5 8322.3 8394.8 8411.2 8411.9 7465.0 7469.7 7484.7 7489.3 7530.0 7300.4 7378.9 7403.6 7409.2 7438.1 6918.8 7031.3 7032.2 7034.0 7058.0 4804.3 4864.8 4948.1 4979.4 5048.6 4879.5 4919.7 4985.2 5045.7 5063.4 09:46:33 INFO - PROCESS | 1937 | 09:46:33 INFO - PROCESS | 1937 | [#4] prototype.html Cycles:180 Average:4270.68 Median:4607.31 stddev:1295.69 (28.1%) stddev-sans-first:1264.34 09:46:33 INFO - PROCESS | 1937 | Values: 286.1 301.9 305.0 312.9 314.4 4421.7 4505.1 5217.3 5304.8 5388.8 4514.0 4567.0 4589.9 4892.2 5224.9 3814.9 3878.4 4006.5 4171.5 4172.7 4091.7 4093.7 4141.9 4143.5 4154.3 3840.0 3973.7 4083.0 4086.1 4131.3 2898.2 3463.4 3553.6 3994.3 4010.1 3506.7 3516.7 3518.3 3522.8 3548.6 4088.4 4810.7 4910.7 5265.7 5301.9 4112.7 4466.9 4612.3 4649.6 4682.8 4575.9 4602.3 5711.8 5721.1 5755.5 3417.9 3869.8 3872.4 3879.6 3887.8 5669.0 5670.9 5675.7 5749.0 5972.6 3440.4 3922.0 3924.4 3924.9 3927.7 3966.7 3977.4 4002.0 4003.3 4009.4 3669.0 4489.9 4671.4 4685.2 4728.1 4688.5 4780.0 5399.4 5658.3 5779.3 1182.7 1294.9 1356.5 1357.1 1363.7 667.8 697.8 816.2 819.7 834.7 4301.0 4390.3 4525.7 4548.8 4569.5 4175.7 4891.9 4900.9 4922.7 4965.0 4309.6 4485.5 4498.7 4530.9 4551.3 2449.6 2595.5 2599.8 2604.5 2618.8 4875.6 5076.8 5078.0 5082.7 5108.8 4330.8 4386.2 4784.3 4978.6 5005.2 3739.2 4500.8 4613.5 5087.3 5103.5 4132.0 4644.7 4677.0 4933.9 4946.6 4268.9 4629.6 4782.3 4847.3 4850.9 4668.2 4717.3 5072.3 5087.6 5111.4 3252.4 3409.4 3421.6 3427.3 3430.8 4280.1 4744.3 4746.5 4880.2 5543.8 4802.2 5246.9 5635.9 5651.4 5666.8 5666.4 5667.7 5670.6 5675.4 5695.3 5250.4 5546.3 5580.2 5593.6 5685.9 5022.6 5291.8 5750.3 5763.3 5777.7 4500.9 5463.6 5628.3 5656.5 5705.5 09:46:33 INFO - PROCESS | 1937 | 09:46:33 INFO - PROCESS | 1937 | [#5] yui.html Cycles:180 Average:23567.02 Median:3687.64 stddev:37286.25 (1011.1%) stddev-sans-first:37351.13 09:46:33 INFO - PROCESS | 1937 | Values: 647.3 659.5 679.7 770.5 856.0 15299.5 16260.3 16266.2 16280.8 16327.5 13338.4 14420.5 14564.9 14705.1 15514.9 827.0 868.3 872.8 874.5 880.7 867.3 871.7 872.6 876.0 878.6 908.3 909.2 913.1 914.1 916.5 902.8 904.8 905.6 907.6 909.9 679.7 679.7 681.3 682.1 691.0 14818.9 15211.6 15256.6 15276.4 15421.0 13800.5 14464.9 14688.9 14738.9 14929.0 10475.2 11391.8 11582.2 11815.4 12015.4 3253.9 3809.9 3820.0 3827.8 3842.4 70499.6 78545.0 82448.0 118446.0 120208.0 10469.0 10668.3 11072.8 11095.8 11237.3 14965.6 17786.9 22024.0 22468.0 22472.9 7703.8 7931.9 8028.9 8175.5 8239.1 4398.4 4512.6 4578.7 4586.5 4674.9 3520.4 3670.3 3680.3 3683.2 3692.1 648.4 671.4 678.1 684.7 687.8 636.8 662.8 680.3 690.2 696.4 8995.5 9742.0 9788.8 9825.9 9910.7 555.9 580.4 668.1 681.9 688.7 4374.1 4767.8 4771.5 4786.6 4872.1 131633.0 149303.0 168621.3 173463.0 176710.0 89255.0 108089.0 109509.9 111107.0 112305.0 89483.0 96538.0 98343.0 100011.0 100569.0 9599.1 10017.5 10019.9 10042.9 10163.3 57709.1 58078.0 58528.7 59435.7 59687.0 81204.0 85588.0 85655.6 86551.0 86597.0 12562.1 12759.9 12781.8 12891.5 13015.5 13871.2 14595.4 14794.3 16094.1 16100.0 13162.0 14290.9 14371.2 14872.6 14928.2 13664.0 13984.7 14085.1 14240.4 14548.9 13889.5 14016.0 14207.0 14652.2 14721.0 11601.2 11662.2 11919.9 12004.5 12076.2 9720.9 11606.5 11637.6 11722.6 11738.2 09:46:33 INFO - PROCESS | 1937 | -------- Summary: end -------- 09:46:33 INFO - PROCESS | 1937 | 09:46:33 INFO - TEST-INFO | 1937: exit 0 09:46:33 INFO - TEST-OK | dromaeo_css | took 1117305ms 09:46:33 INFO - TEST-START | kraken 09:46:33 INFO - operating with platform_type : mac_ 09:46:33 INFO - Initialising browser for kraken test... 09:46:33 INFO - TEST-INFO | started process 1941 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/tmp8jg65i/profile http://localhost:50912/getInfo.html) 09:46:36 INFO - PROCESS | 1941 | __metrics Screen width/height:1600/1200 09:46:36 INFO - PROCESS | 1941 | colorDepth:24 09:46:36 INFO - PROCESS | 1941 | Browser inner width/height: 1024/689 09:46:36 INFO - PROCESS | 1941 | __metrics 09:46:36 INFO - PROCESS | 1941 | 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" 09:46:36 INFO - PROCESS | 1941 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:46:37 INFO - TEST-INFO | 1941: exit 0 09:46:37 INFO - Browser initialized. 09:46:37 INFO - Running cycle 1/1 for kraken test... 09:46:37 INFO - TEST-INFO | started process 1942 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/tmp8jg65i/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:46:49 INFO - PROCESS | 1942 | RSS: Main: 219889664 09:46:49 INFO - PROCESS | 1942 | 09:46:51 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:50912/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50912/tests/kraken/driver.html?testName=audio-beat-detection) 09:46:52 INFO - PROCESS | 1942 | RSS: Main: 269807616 09:46:52 INFO - PROCESS | 1942 | 09:46:55 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:50912/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50912/tests/kraken/driver.html?testName=audio-dft) 09:46:55 INFO - PROCESS | 1942 | RSS: Main: 280125440 09:46:55 INFO - PROCESS | 1942 | 09:46:59 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:50912/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50912/tests/kraken/driver.html?testName=audio-fft) 09:46:59 INFO - PROCESS | 1942 | RSS: Main: 375480320 09:46:59 INFO - PROCESS | 1942 | 09:47:01 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:50912/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50912/tests/kraken/driver.html?testName=audio-oscillator) 09:47:02 INFO - PROCESS | 1942 | RSS: Main: 280399872 09:47:02 INFO - PROCESS | 1942 | 09:47:04 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:50912/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50912/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:47:04 INFO - PROCESS | 1942 | RSS: Main: 280961024 09:47:04 INFO - PROCESS | 1942 | 09:47:07 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:50912/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50912/tests/kraken/driver.html?testName=imaging-darkroom) 09:47:08 INFO - PROCESS | 1942 | RSS: Main: 317718528 09:47:08 INFO - PROCESS | 1942 | 09:47:11 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:50912/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50912/tests/kraken/driver.html?testName=imaging-desaturate) 09:47:11 INFO - PROCESS | 1942 | RSS: Main: 319033344 09:47:11 INFO - PROCESS | 1942 | 09:47:14 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:50912/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50912/tests/kraken/driver.html?testName=json-parse-financial) 09:47:15 INFO - PROCESS | 1942 | RSS: Main: 315232256 09:47:15 INFO - PROCESS | 1942 | 09:47:16 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:50912/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50912/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:47:17 INFO - PROCESS | 1942 | RSS: Main: 291004416 09:47:17 INFO - PROCESS | 1942 | 09:47:19 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:50912/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50912/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:47:19 INFO - PROCESS | 1942 | RSS: Main: 295104512 09:47:19 INFO - PROCESS | 1942 | 09:47:22 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:50912/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50912/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:47:22 INFO - PROCESS | 1942 | RSS: Main: 300810240 09:47:22 INFO - PROCESS | 1942 | 09:47:25 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:50912/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50912/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:47:26 INFO - PROCESS | 1942 | RSS: Main: 309968896 09:47:26 INFO - PROCESS | 1942 | 09:47:29 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:50912/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50912/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:47:29 INFO - PROCESS | 1942 | RSS: Main: 309932032 09:47:29 INFO - PROCESS | 1942 | 09:47:31 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:50912/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50912/tests/kraken/driver.html?testName=ai-astar) 09:47:31 INFO - PROCESS | 1942 | RSS: Main: 353796096 09:47:31 INFO - PROCESS | 1942 | 09:47:31 INFO - PROCESS | 1942 | __start_tp_report 09:47:31 INFO - PROCESS | 1942 | _x_x_mozilla_page_load 09:47:31 INFO - PROCESS | 1942 | _x_x_mozilla_page_load_details 09:47:31 INFO - PROCESS | 1942 | |i|pagename|runs| 09:47:31 INFO - PROCESS | 1942 | |0;ai-astar;115;112;112;112;113;113;113;113;112;112 09:47:31 INFO - PROCESS | 1942 | |1;audio-beat-detection;146;110;109;145;108;110;105;106;136;109 09:47:31 INFO - PROCESS | 1942 | |2;audio-dft;183;184;185;185;183;185;182;184;190;183 09:47:31 INFO - PROCESS | 1942 | |3;audio-fft;81;60;58;89;62;58;57;58;82;57 09:47:31 INFO - PROCESS | 1942 | |4;audio-oscillator;101;102;115;100;73;70;92;67;68;90 09:47:31 INFO - PROCESS | 1942 | |5;imaging-gaussian-blur;113;85;88;84;87;84;87;84;84;83 09:47:31 INFO - PROCESS | 1942 | |6;imaging-darkroom;95;95;96;96;96;112;169;125;96;95 09:47:31 INFO - PROCESS | 1942 | |7;imaging-desaturate;85;86;84;86;86;83;86;85;86;86 09:47:31 INFO - PROCESS | 1942 | |8;json-parse-financial;57;53;52;54;57;59;59;57;58;58 09:47:31 INFO - PROCESS | 1942 | |9;json-stringify-tinderbox;65;77;81;73;72;70;69;70;70;72 09:47:31 INFO - PROCESS | 1942 | |10;stanford-crypto-aes;81;82;82;84;81;79;81;80;99;101 09:47:31 INFO - PROCESS | 1942 | |11;stanford-crypto-ccm;138;148;140;150;137;140;136;140;197;135 09:47:31 INFO - PROCESS | 1942 | |12;stanford-crypto-pbkdf2;161;162;165;161;222;206;164;166;165;163 09:47:31 INFO - PROCESS | 1942 | |13;stanford-crypto-sha256-iterative;64;65;86;65;60;61;83;84;84;87 09:47:31 INFO - PROCESS | 1942 | __end_tp_report 09:47:31 INFO - PROCESS | 1942 | __start_cc_report 09:47:31 INFO - PROCESS | 1942 | _x_x_mozilla_cycle_collect,1918 09:47:31 INFO - PROCESS | 1942 | __end_cc_report 09:47:31 INFO - PROCESS | 1942 | __startTimestamp1478191651880__endTimestamp 09:47:31 INFO - PROCESS | 1942 | 09:47:31 INFO - PROCESS | 1942 | ------- Summary: start ------- 09:47:31 INFO - PROCESS | 1942 | Number of tests: 14 09:47:31 INFO - PROCESS | 1942 | 09:47:31 INFO - PROCESS | 1942 | [#0] ai-astar Cycles:10 Average:112.70 Median:113.00 stddev:0.95 (0.8%) stddev-sans-first:0.53 09:47:31 INFO - PROCESS | 1942 | Values: 115.0 112.0 112.0 112.0 113.0 113.0 113.0 113.0 112.0 112.0 09:47:31 INFO - PROCESS | 1942 | 09:47:31 INFO - PROCESS | 1942 | [#1] audio-beat-detection Cycles:10 Average:118.40 Median:110.00 stddev:16.79 (15.3%) stddev-sans-first:14.54 09:47:31 INFO - PROCESS | 1942 | Values: 146.0 110.0 109.0 145.0 108.0 110.0 105.0 106.0 136.0 109.0 09:47:31 INFO - PROCESS | 1942 | 09:47:31 INFO - PROCESS | 1942 | [#2] audio-dft Cycles:10 Average:184.40 Median:184.50 stddev:2.22 (1.2%) stddev-sans-first:2.30 09:47:31 INFO - PROCESS | 1942 | Values: 183.0 184.0 185.0 185.0 183.0 185.0 182.0 184.0 190.0 183.0 09:47:31 INFO - PROCESS | 1942 | 09:47:31 INFO - PROCESS | 1942 | [#3] audio-fft Cycles:10 Average:66.20 Median:61.00 stddev:12.54 (20.6%) stddev-sans-first:12.10 09:47:31 INFO - PROCESS | 1942 | Values: 81.0 60.0 58.0 89.0 62.0 58.0 57.0 58.0 82.0 57.0 09:47:31 INFO - PROCESS | 1942 | 09:47:31 INFO - PROCESS | 1942 | [#4] audio-oscillator Cycles:10 Average:87.80 Median:69.00 stddev:17.15 (24.9%) stddev-sans-first:17.51 09:47:31 INFO - PROCESS | 1942 | Values: 101.0 102.0 115.0 100.0 73.0 70.0 92.0 67.0 68.0 90.0 09:47:31 INFO - PROCESS | 1942 | 09:47:31 INFO - PROCESS | 1942 | [#5] imaging-gaussian-blur Cycles:10 Average:87.90 Median:84.50 stddev:8.97 (10.6%) stddev-sans-first:1.76 09:47:31 INFO - PROCESS | 1942 | Values: 113.0 85.0 88.0 84.0 87.0 84.0 87.0 84.0 84.0 83.0 09:47:31 INFO - PROCESS | 1942 | 09:47:31 INFO - PROCESS | 1942 | [#6] imaging-darkroom Cycles:10 Average:107.50 Median:95.50 stddev:23.82 (24.9%) stddev-sans-first:24.83 09:47:31 INFO - PROCESS | 1942 | Values: 95.0 95.0 96.0 96.0 96.0 112.0 169.0 125.0 96.0 95.0 09:47:31 INFO - PROCESS | 1942 | 09:47:31 INFO - PROCESS | 1942 | [#7] imaging-desaturate Cycles:10 Average:85.30 Median:86.00 stddev:1.06 (1.2%) stddev-sans-first:1.12 09:47:31 INFO - PROCESS | 1942 | Values: 85.0 86.0 84.0 86.0 86.0 83.0 86.0 85.0 86.0 86.0 09:47:31 INFO - PROCESS | 1942 | 09:47:31 INFO - PROCESS | 1942 | [#8] json-parse-financial Cycles:10 Average:56.40 Median:57.50 stddev:2.50 (4.4%) stddev-sans-first:2.65 09:47:31 INFO - PROCESS | 1942 | Values: 57.0 53.0 52.0 54.0 57.0 59.0 59.0 57.0 58.0 58.0 09:47:31 INFO - PROCESS | 1942 | 09:47:31 INFO - PROCESS | 1942 | [#9] json-stringify-tinderbox Cycles:10 Average:71.90 Median:72.00 stddev:4.43 (6.2%) stddev-sans-first:3.94 09:47:31 INFO - PROCESS | 1942 | Values: 65.0 77.0 81.0 73.0 72.0 70.0 69.0 70.0 70.0 72.0 09:47:31 INFO - PROCESS | 1942 | 09:47:31 INFO - PROCESS | 1942 | [#10] stanford-crypto-aes Cycles:10 Average:85.00 Median:81.50 stddev:8.03 (9.8%) stddev-sans-first:8.38 09:47:31 INFO - PROCESS | 1942 | Values: 81.0 82.0 82.0 84.0 81.0 79.0 81.0 80.0 99.0 101.0 09:47:31 INFO - PROCESS | 1942 | 09:47:31 INFO - PROCESS | 1942 | [#11] stanford-crypto-ccm Cycles:10 Average:146.10 Median:140.00 stddev:18.54 (13.2%) stddev-sans-first:19.44 09:47:31 INFO - PROCESS | 1942 | Values: 138.0 148.0 140.0 150.0 137.0 140.0 136.0 140.0 197.0 135.0 09:47:31 INFO - PROCESS | 1942 | 09:47:31 INFO - PROCESS | 1942 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.50 Median:165.00 stddev:21.74 (13.2%) stddev-sans-first:22.59 09:47:31 INFO - PROCESS | 1942 | Values: 161.0 162.0 165.0 161.0 222.0 206.0 164.0 166.0 165.0 163.0 09:47:31 INFO - PROCESS | 1942 | 09:47:31 INFO - PROCESS | 1942 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.90 Median:83.50 stddev:11.65 (13.9%) stddev-sans-first:11.79 09:47:31 INFO - PROCESS | 1942 | Values: 64.0 65.0 86.0 65.0 60.0 61.0 83.0 84.0 84.0 87.0 09:47:31 INFO - PROCESS | 1942 | -------- Summary: end -------- 09:47:31 INFO - PROCESS | 1942 | 09:47:32 INFO - TEST-INFO | 1942: exit 0 09:47:32 INFO - TEST-OK | kraken | took 58828ms 09:47:32 INFO - SUITE-END | took 1176s 09:47:33 INFO - Completed test suite (00:19:36) 09:47:33 INFO - javascript benchmark 09:47:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3248.3990461764574, 3263.249452625896, 3277.066036179691, 3289.2928020475624, 3328.8335583220833, 5613.831585052445, 5679.7160141992945, 5693.572982026344, 5703.800366987151, 5707.115397113449, 5618.550515958724, 5693.971530142344, 5713.771449142039, 5717.142428635707, 5726.885462290752, 5155.5360017598405, 5159.793608255665, 5162.380514338284, 5208.427073021964, 5214.8696282592855, 5118.4113826909825, 5125.436202017775, 5154.561862241714, 5275.815346462875, 5315.0, 5217.608679349045, 5239.423663397023, 5242.161254199329, 5242.6330156889035, 5257.76340064698, 5232.555232805216, 5234.7120908350025, 5235.712035838027, 5239.3712754469325, 5244.68531888086, 5077.314562534048, 5188.481151884781, 5199.506046925536, 5208.166693329087, 5232.8691782705355, 5642.181883626851, 5654.264945557093, 5675.829725108253, 5702.971485142589, 5705.486506214419, 6142.815715528542, 6154.984427569446, 6225.0, 6241.812745617639, 6245.156903818017, 4906.803727850882, 6126.823043872694, 6276.403741644536, 6281.654509002003, 6303.0, 5666.46168613981, 5685.976524225596, 5692.203091567184, 5700.486956173964, 5744.0, 5219.0, 5839.5036421904615, 6200.286966998763, 6208.255009398901, 6216.160818289563, 6163.445289923929, 6165.568410211332, 6172.321044685081, 6173.166622505904, 6185.8453538661, 6092.390760923872, 6107.454994951028, 6126.366913828976, 6135.134730314741, 6192.318844927055, 6122.448979591769, 6189.133521307021, 6190.628562286277, 6193.473554747897, 6201.317855035943, 6191.9690401547705, 6214.8135555933395, 6225.221847269091, 6228.937710622927, 6237.033259844731, 4819.662623616383, 4862.6839255448285, 4867.805287788519, 4875.536824001714, 4934.284528743312, 3681.7975011374097, 4285.892852678708, 4316.460442444694, 4335.328024156261, 4345.630621397217, 5572.60991730575, 5583.497485226268, 5588.385277619459, 5610.214569960209, 5629.971850140805, 5095.184770436712, 6107.236595425572, 6131.6213479391645, 6154.107654390088, 6156.753729850845, 5624.0, 5630.60585758993, 5652.717364131777, 5725.2843394575675, 5811.56413268998, 5385.73071346439, 5396.379416367168, 5397.109476936262, 5402.37872644643, 5410.458954104558, 6257.687115644108, 6273.749050037947, 6278.372162783685, 6280.497560195174, 6282.842928926813, 6136.478399336106, 6136.693165341626, 6151.954167791576, 6168.876622467616, 6214.9689251553455, 6239.407256310643, 6250.4374606285655, 6252.562320637512, 6253.593516421418, 6273.592216505913, 6102.481289090477, 6130.969345153246, 6153.661548614869, 6168.228971378578, 6179.443850053517, 5385.0037743017665, 6101.084837274444, 6113.633182009094, 6148.938510615016, 6153.969230153821, 5923.378045305181, 5962.433568810956, 6069.484093852072, 6094.664793436404, 6117.388261174025, 6073.908891366721, 6077.939220607737, 6081.604695694766, 6092.786752463642, 6099.451049405575, 5749.993751093458, 5817.5345972321265, 5864.091065884794, 5919.852003699942, 5923.229980102559, 5997.220361352996, 6002.3097343804275, 6044.90932636002, 6119.510439164945, 6144.969275153596, 5909.940900591111, 5919.7040147991565, 5933.228680271537, 5940.702964851654, 5952.5833191676165], "value": 5634.953072770093, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [437.481584322578, 481.79070532962277, 517.9093658609744, 520.0846510142148, 542.5713686187912, 21662.783372166272, 31346.686533134663, 39918.40122398163, 41025.76922692324, 41404.792976035074, 42376.788116059455, 42732.786336068275, 42768.0, 42797.0, 42855.78572107143, 8286.875696864538, 9919.404835709844, 9926.057024582653, 9930.65242716505, 9933.00669933008, 8778.122187781235, 8978.0, 9664.371815831948, 11872.22830516018, 12102.757944841098, 12151.27092374456, 12200.755984880341, 12241.693957651041, 12243.510259589606, 12250.93874530626, 12186.939065304661, 12229.633111006684, 12235.510579576807, 12236.694082647917, 12260.325682087527, 8450.535220562866, 8668.696595619185, 11746.060315174765, 12078.15452918296, 12106.757864842653, 34662.48006279908, 37719.05702357436, 39187.608123918966, 39550.406743898864, 39557.0, 3290.3912776136253, 3335.8665653373837, 3371.511130886008, 3610.765300255475, 3988.3020471417385, 29166.562501562494, 29436.852815735783, 30813.383732325226, 31374.215644608837, 32185.83907080473, 3305.752068594841, 3321.0701003718996, 3328.0182346207926, 3334.283129127225, 3356.8992930212135, 527175.0, 541615.0, 541782.2910885459, 542536.0, 542830.0, 67263.0, 68066.319336806, 68076.0, 68143.65928170328, 68180.6590967042, 70581.0, 71114.0, 71176.64411677909, 71202.0, 71354.64322678353, 17058.48824535266, 17650.470485885446, 17692.026938518506, 17716.734248986275, 17721.822781772018, 11992.940035299767, 13196.406161722745, 13339.132956357806, 13388.598342049754, 13400.865991339962, 16628.916855415646, 17302.394416195373, 20272.797272027386, 20359.8982005092, 20896.791032089484, 8305.8338833223, 8354.624041918129, 8363.832723345498, 8368.916310836814, 8443.873341899876, 864.9524276164872, 913.5930666773228, 962.259060523393, 1016.3850870223556, 1114.5597488991964, 29952.550711739343, 30008.849955750517, 30167.0, 30244.697553024187, 30324.84837575798, 1031.9587216511406, 1066.9573217071386, 1088.5373716170755, 1164.941752912351, 1173.5892437646755, 14857.777133343008, 15112.094659928054, 15599.064056156667, 15840.60398490047, 16010.199490025452, 712886.0, 717076.0, 718226.0, 719465.0, 720385.0, 57284.71357643185, 57776.0, 57841.710791445774, 57923.0, 57951.13073303904, 1237.641084085623, 1279.923204607708, 1354.3769865861814, 1376.779715245556, 1406.648337915521, 29774.8511257451, 31489.685103148677, 31576.052718418483, 31577.684223158394, 31954.520682189323, 48757.0, 49330.26004609862, 49338.75330623324, 49372.0, 49464.0, 533530.0, 536180.0, 537055.0, 538449.0, 538955.0, 20930.0, 27322.726772732018, 27450.725492745616, 28224.71775282303, 42875.928101797705, 47205.76397117993, 47235.0, 47588.81027974328, 47612.047759045316, 47802.521974779804, 38058.429123562615, 39258.411123833735, 40659.796701016305, 41215.587844122376, 41243.1751364977, 38996.61003390043, 39141.608583913796, 39719.40420893747, 40172.799136004134, 40282.0, 38393.61606383901, 38534.61465385422, 38731.2253754929, 38983.22033559256, 39053.2189356217, 33021.009369718944, 34036.0, 34705.82647086748, 34712.479312810836, 35296.64703353036, 24642.753572464764, 25953.870230648725, 26155.215343539723, 26725.19824405271, 26786.464270714867], "value": 20776.40523177309, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [355.80075157911557, 374.42151875352596, 375.66753423220445, 386.5960071725047, 407.4947065638607, 15021.62445938852, 15635.921820390897, 17307.04811235383, 20553.69169462459, 20727.06728197231, 19490.415287541397, 20648.896755516238, 21307.25424610139, 21393.0373133209, 21483.355499335004, 5931.110333449974, 5985.610935289204, 6136.509079273647, 6237.719302631393, 6238.812835614916, 4232.936505952413, 6083.574149809515, 6188.288346840126, 6194.721237544321, 6195.5663103582765, 4438.822447102112, 6573.638449885254, 6863.828404289883, 6896.137982752156, 6990.5456145350645, 5253.0, 5908.586398952075, 6252.687365631746, 6951.930480695204, 6993.720251189946, 6127.20346354971, 6139.0, 6143.907841382383, 6145.539084568631, 6145.969270153665, 13383.464661413533, 13487.325633718374, 13699.178049317074, 13835.03154779166, 13846.10000349974, 2170.511634882155, 2261.8416710830247, 2396.928092157238, 2649.713288456744, 2861.470627933839, 10169.389836609827, 10267.486625668687, 10674.0, 10702.839457408145, 10708.1433485321, 1755.7893052833742, 1985.8808471491757, 1988.8906110163934, 1991.8804871707598, 2003.7294965179806, 122325.0, 126986.0, 129185.0, 131320.06039818822, 133025.66974330327, 7665.463417560717, 8211.95894020538, 10138.442385668712, 10205.234607404474, 11672.649820505398, 12448.439820208112, 12530.686732831753, 12544.937275313747, 12558.372081395893, 12561.183523070971, 8262.256396924186, 8347.207015333533, 8367.330613550901, 8373.623186956602, 8516.318694504425, 8794.164554367326, 8795.51624660637, 8812.515311657791, 8947.239484643747, 8959.776005599912, 3965.20695860829, 3966.8809935701975, 3975.801209939549, 4026.033751899523, 4040.8989775255855, 1662.5760431089996, 1932.439592518182, 1974.3385965701364, 1974.792646772097, 2014.113789932425, 826.277007618334, 869.1959937058323, 912.4206129107931, 947.4982153287117, 993.0714781679153, 21854.125834966424, 22179.891005449663, 22183.889080554494, 22271.777282227293, 22318.0, 931.0689310689311, 937.5373223456397, 942.604106275366, 974.1573538888811, 1002.7142264454595, 10826.458677066115, 11667.59163429276, 11686.065114790796, 11703.707407314885, 11710.00464960488, 591172.0, 612331.0, 618149.0, 618732.0, 636154.0, 134871.0, 140640.0, 141866.87199692012, 143870.2806485961, 144180.27909860385, 898.60910503931, 957.5260246178186, 999.14073896449, 1026.3226270661328, 1034.6016783538391, 19541.316053938044, 20470.897645511675, 20511.38465846027, 20563.0, 20739.585208296052, 54999.17501237565, 56089.43910560842, 57236.0, 57299.0, 57461.42538574728, 83116.58441707752, 84045.15954840374, 84925.57537212274, 85447.5727621358, 88202.67695984694, 8212.58937053133, 8223.54770487629, 8363.247307742333, 8466.576671166295, 8745.737627871174, 12527.686807829512, 13339.0, 13473.46106155782, 14038.929805350908, 14207.715845683235, 9710.368826026286, 11580.36308003068, 11694.356810375511, 12048.578299759816, 12091.697707557381, 11559.36423496682, 11621.0, 11629.418529073682, 11835.408229588314, 12034.217775844892, 11656.417179140839, 11905.226160299553, 11965.042796576427, 12094.185872119253, 12120.636380908587, 7141.357277845019, 8236.629351679308, 8388.077311495608, 8390.664373424994, 8635.352348573757, 8903.554822258991, 9453.763655908657, 11714.589989350332, 12080.879191207976, 12122.696932576757], "value": 9590.756944760316, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1340.269553093564, 1499.7375459294624, 1534.2635534943227, 1733.4106403822705, 1919.7408349872762, 7896.723614673488, 8472.406931514797, 8621.52581608012, 8926.553672316391, 8939.374243802937, 8599.656013759442, 8931.106889311082, 8936.017038125801, 8942.731718048453, 8948.28413726902, 2388.6417037444394, 2446.425090103824, 2447.36368544178, 2449.0448724997264, 2453.987730061347, 2402.3633737059604, 2429.708434987804, 2446.7430919753347, 2450.4608986023136, 2456.152627343564, 2202.185191479155, 2361.7047869016374, 2405.855648661086, 2417.476989496615, 2425.4785221177444, 2386.916457923982, 2407.7471865454136, 2415.311636183679, 2420.3828023853803, 2430.769076937688, 2324.9883750581307, 2409.9879500602383, 2411.6623672685837, 2413.3363325085566, 2417.589009868309, 7954.125046244909, 8113.8782918256275, 8921.01868794432, 9008.684696035672, 9010.098990101003, 4935.901281974377, 5081.339425874649, 5105.923411148836, 5110.10573149701, 5303.681779093266, 3613.7470377073614, 3625.6947498900377, 3664.285464334456, 3713.1459764254373, 3721.2557488502407, 959.6065613098596, 1096.1942971915635, 1109.1958330210614, 1120.0479592346521, 1139.9512448547273, 11767.058635309155, 11836.644900652995, 11910.225835320676, 11939.701507462296, 11940.641780746591, 4175.227582897173, 4220.164228560586, 4701.7414042228, 4749.145153872336, 4954.232094025359, 10223.284370094021, 10223.335483193569, 10230.488475576192, 10240.948795255976, 10246.129079028216, 5471.0, 5475.72621368938, 5476.096444086681, 5478.643888147258, 5490.313710786152, 4784.354112194878, 4916.385451818523, 4957.405111386656, 4995.675281106716, 5000.0, 3834.827432765532, 3854.3447613905705, 3898.1034362096875, 3940.605939406094, 3955.7033222508426, 1194.3371428856894, 1196.6948428150765, 1200.7598480303975, 1204.8433703618473, 1208.9214201076902, 744.6351287869013, 848.8896443462311, 900.8333458310234, 912.9132732390412, 930.1721467893581, 5662.85842853932, 5777.913331300034, 5805.129230615442, 5959.73181206838, 6095.1771510845465, 863.5293764898146, 911.1253196930888, 913.917747402737, 950.1591091883595, 961.7547525381123, 3828.272628200633, 3900.9609903901164, 3909.237698648793, 3933.488646475997, 3954.169624378855, 10756.085732712807, 10977.670669879917, 11021.83467247992, 11035.337879727242, 11037.227394082498, 10969.506372213269, 10973.286736362112, 10980.725481862857, 10980.890191098146, 10984.176186785864, 7847.0, 8189.754307370788, 8215.630296636546, 8269.46248493858, 8307.210814972568, 5897.941020589911, 5939.376365481562, 6005.978983572716, 6012.819615411545, 6101.389861013863, 9701.951490242785, 9942.204623630238, 10237.181025517792, 10239.180865530889, 10240.334378265388, 10208.540615672164, 10334.586616535255, 10349.689509314732, 10393.168546516412, 10504.632337868137, 7511.0, 7655.655495502604, 7778.766637000899, 7781.5331080135375, 7787.260210280015, 8314.501129932223, 8322.250997410261, 8394.832103358021, 8411.242988131098, 8411.915880841114, 7465.0, 7469.701211951461, 7484.663190156565, 7489.28851759082, 7529.962350188214, 7300.415966722543, 7378.889316660147, 7403.629818509161, 7409.222031686595, 7438.144613369532, 6918.827029324106, 7031.261717519586, 7032.226455090038, 7034.015237866601, 7057.964710176417, 4804.25534042224, 4864.8324402143935, 4948.134076536519, 4979.377577802775, 5048.59611231108, 4879.512048795092, 4919.671757916463, 4985.227289770091, 5045.672031317952, 5063.367079115111], "value": 4618.8627934073265, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [286.1159018632425, 301.93659331540374, 304.96645369009406, 312.90769223079195, 314.3979279679414, 4421.66837487189, 4505.053938672874, 5217.287010754406, 5304.787808487661, 5388.784448622056, 4514.029483661012, 4567.0, 4589.908201835961, 4892.217245240762, 5224.8693782655355, 3814.9427758583643, 3878.3600705883496, 4006.4991876015497, 4171.520275168349, 4172.705012243269, 4091.7340372875815, 4093.7339072960162, 4141.896452588694, 4143.482064741907, 4154.273002224613, 3839.9616003840024, 3973.7417067890638, 4083.0404854859084, 4086.121483880965, 4131.338985762279, 2898.2029941765973, 3463.3765922134007, 3553.5558055243096, 3994.2610617035652, 4010.137820368635, 3506.66686664769, 3516.7010804081683, 3518.313928783888, 3522.771019883725, 3548.627394123606, 4088.4480595119576, 4810.687305325143, 4910.680805747651, 5265.6577322474295, 5301.879248300672, 4112.712110152291, 4466.927937295026, 4612.331211974279, 4649.558291962258, 4682.765861706901, 4575.931361029588, 4602.286645569942, 5711.8000869969765, 5721.0846264597885, 5755.510781583571, 3417.9316413671836, 3869.806509674533, 3872.380419132953, 3879.553851307079, 3887.844486220548, 5669.0, 5670.894175635753, 5675.659460432346, 5749.0, 5972.611780234271, 3440.4323286657423, 3921.960680419691, 3924.411338299221, 3924.9018774530296, 3927.6857851371824, 3966.690991972642, 3977.423273625308, 4001.9799901000893, 4003.2577684285775, 4009.4363198352667, 3668.991027467468, 4489.932651010237, 4671.43942726875, 4685.156671799041, 4728.101660684528, 4688.484266730657, 4779.95220047802, 5399.352077750695, 5658.264425624642, 5779.2775903012125, 1182.6984119049587, 1294.9287789171497, 1356.4913157565913, 1357.0907491980397, 1363.6931690369588, 667.8063361625171, 697.8115908704723, 816.2408959667566, 819.6885183630302, 834.6953362022819, 4301.010767523487, 4390.275604525217, 4525.683202175882, 4548.795304211319, 4569.451665800058, 4175.6868234881895, 4891.877703057452, 4900.897298107969, 4922.704637721748, 4965.013994402268, 4309.586631486378, 4485.46174459067, 4498.672891496951, 4530.864074077783, 4551.316013075183, 2449.595816690262, 2595.454954459547, 2599.8291426658575, 2604.479104179172, 2618.751218634227, 4875.634327425386, 5076.771545280471, 5077.974610126926, 5082.74586270685, 5108.821191258288, 4330.783460826946, 4386.210482113251, 4784.30627559002, 4978.551930326215, 5005.199168133081, 3739.233457141334, 4500.804428855484, 4613.515580863961, 5087.287779710918, 5103.464136265638, 4132.016632016589, 4644.744539050384, 4677.017826256388, 4933.851984440473, 4946.554810067111, 4268.893277668083, 4629.629629629554, 4782.2826576012485, 4847.2729090636685, 4850.865619127714, 4668.206404911241, 4717.292406139107, 5072.264521644414, 5087.618428617794, 5111.361079865017, 3252.3818326247597, 3409.4374428219066, 3421.5894092709036, 3427.2802711430877, 3430.811305378228, 4280.143971205709, 4744.346852923299, 4746.501617330131, 4880.1934491097, 5543.778248870161, 4802.247179779425, 5246.868828279324, 5635.8591035224445, 5651.406602306699, 5666.773329066956, 5666.405027472221, 5667.744951477111, 5670.574706896917, 5675.432456754456, 5695.288088988877, 5250.422453530185, 5546.310039630695, 5580.2466666999435, 5593.580481463825, 5685.8862822742485, 5022.564056432554, 5291.76187071575, 5750.25246717924, 5763.33721622002, 5777.653340799566, 4500.9099818004115, 5463.617546771688, 5628.296462942132, 5656.490915817596, 5705.515031222392], "value": 3860.0318901574137, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [647.3106141958814, 659.5119611487497, 679.7281087564974, 770.4953255617565, 855.9786005349862, 15299.54101376959, 16260.349586016546, 16266.186690665478, 16280.83719162808, 16327.510174694764, 13338.399772010258, 14420.49528266511, 14564.854351456483, 14705.117692938431, 15514.922425387886, 826.9627866745981, 868.3096937934357, 872.7818045488627, 874.470945078228, 880.6521424037502, 867.2541614211773, 871.6992637540038, 872.5593575244525, 876.0, 878.6353663229752, 908.2824568590805, 909.1908201700492, 913.1416468519603, 914.0676509959837, 916.4501299220448, 902.7743064233941, 904.8326059678981, 905.5879574793453, 907.6324088744036, 909.9363044586881, 679.7111227728245, 679.7145199016425, 681.2608319972835, 682.0621645237798, 690.9550879192836, 14818.851811481854, 15211.61970950724, 15256.618584535365, 15276.38894444221, 15421.0, 13800.516981905585, 14464.927675361661, 14688.926555367261, 14738.852611473856, 14929.0, 10475.214358923035, 11391.829122563167, 11582.247153934968, 11815.350155741431, 12015.399230038463, 3253.902382928516, 3809.9238015239816, 3819.9809000955097, 3827.827747751358, 3842.4428457873732, 70499.64750176268, 78545.0, 82448.0, 118446.0, 120208.0, 10469.005444482762, 10668.253222274521, 11072.833907491395, 11095.778084438427, 11237.3257604544, 14965.551033469013, 17786.932784033, 22024.008919598655, 22468.0, 22472.887635561718, 7703.807404814925, 7931.920680793233, 8028.919710802934, 8175.509469431734, 8239.052508961426, 4398.428204333416, 4512.593866552026, 4578.725276483422, 4586.518415566385, 4674.883127921761, 3520.383932811799, 3670.33933891902, 3680.300742858848, 3683.189698266377, 3692.095436618046, 648.4271663136154, 671.405805861806, 678.0947435174098, 684.674779479753, 687.7558466744334, 636.7803107927757, 662.8243515468405, 680.2823021712043, 690.2407351912856, 696.3871792822284, 8995.460272383678, 9742.0, 9788.755281118029, 9825.852612210823, 9910.653127140515, 555.8804856955774, 580.4166812353558, 668.0680450771147, 681.9352161544646, 688.7004153193377, 4374.059577190919, 4767.809287628525, 4771.5228477152, 4786.64100192487, 4872.123017856819, 131633.0, 149303.0, 168621.31378686056, 173463.0, 176710.0, 89255.0, 108089.0, 109509.90490094997, 111107.0, 112305.0, 89483.0, 96538.0, 98343.0, 100011.0, 100569.0, 9599.088086631758, 10017.499125043865, 10019.899801001897, 10042.949785251027, 10163.28856980034, 57709.13436298375, 58078.0, 58528.707356462946, 59435.70282148562, 59687.0, 81204.0, 85588.0, 85655.57172214099, 86551.0, 86597.0, 12562.120651554304, 12759.93620031894, 12781.8082728761, 12891.48434062627, 13015.544455943997, 13871.167729936236, 14595.416183352547, 14794.260286985824, 16094.114823684342, 16100.0, 13162.0, 14290.928545357207, 14371.20958347301, 14872.62818429548, 14928.178950157411, 13664.0, 13984.681971398093, 14085.08446950945, 14240.359183836545, 14548.908831837443, 13889.513867014606, 14016.018878678395, 14207.0, 14652.19412932299, 14721.043132196373, 11601.187916846078, 11662.241954272946, 11919.880801192225, 12004.519819207135, 12076.21504602198, 9720.854187187339, 11606.47770850297, 11637.592684256011, 11722.648320550397, 11738.237014594024], "value": 7828.450775163672, "unit": "score"}], "name": "dromaeo_css", "value": 7342.787494734063, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 112.0, 112.0, 112.0, 113.0, 113.0, 113.0, 113.0, 112.0, 112.0], "value": 112.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 110.0, 109.0, 145.0, 108.0, 110.0, 105.0, 106.0, 136.0, 109.0], "value": 118.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 184.0, 185.0, 185.0, 183.0, 185.0, 182.0, 184.0, 190.0, 183.0], "value": 184.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 60.0, 58.0, 89.0, 62.0, 58.0, 57.0, 58.0, 82.0, 57.0], "value": 66.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 102.0, 115.0, 100.0, 73.0, 70.0, 92.0, 67.0, 68.0, 90.0], "value": 87.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 85.0, 88.0, 84.0, 87.0, 84.0, 87.0, 84.0, 84.0, 83.0], "value": 87.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 96.0, 96.0, 112.0, 169.0, 125.0, 96.0, 95.0], "value": 107.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 84.0, 86.0, 86.0, 83.0, 86.0, 85.0, 86.0, 86.0], "value": 85.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 53.0, 52.0, 54.0, 57.0, 59.0, 59.0, 57.0, 58.0, 58.0], "value": 56.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 77.0, 81.0, 73.0, 72.0, 70.0, 69.0, 70.0, 70.0, 72.0], "value": 71.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 82.0, 84.0, 81.0, 79.0, 81.0, 80.0, 99.0, 101.0], "value": 85.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 148.0, 140.0, 150.0, 137.0, 140.0, 136.0, 140.0, 197.0, 135.0], "value": 146.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 165.0, 161.0, 222.0, 206.0, 164.0, 166.0, 165.0, 163.0], "value": 173.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 86.0, 65.0, 60.0, 61.0, 83.0, 84.0, 84.0, 87.0], "value": 73.9, "unit": "score"}], "name": "kraken", "value": 1457.0, "alertThreshold": 2.0}]} 09:47:33 INFO - Return code: 0 09:47:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:47:33 INFO - # TBPL SUCCESS # 09:47:33 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:47:33 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:47:33 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:47:33 INFO - 2016-11-03 09:47:33.162 screenresolution[1946:16582] starting screenresolution argv=screenresolution get 09:47:33 INFO - 2016-11-03 09:47:33.164 screenresolution[1946:16582] Display 0: 1600x1200x32@60 09:47:33 INFO - 2016-11-03 09:47:33.171 screenresolution[1947:16585] starting screenresolution argv=screenresolution list 09:47:33 INFO - Available Modes on Display 0 09:47:33 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:47:33 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:47:33 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:47:33 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:47:33 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:47:33 INFO - Intel Iris: 09:47:33 INFO - Chipset Model: Intel Iris 09:47:33 INFO - Type: GPU 09:47:33 INFO - Bus: Built-In 09:47:33 INFO - VRAM (Dynamic, Max): 1536 MB 09:47:33 INFO - Vendor: Intel (0x8086) 09:47:33 INFO - Device ID: 0x0a2e 09:47:33 INFO - Revision ID: 0x0009 09:47:33 INFO - Displays: 09:47:33 INFO - Display: 09:47:33 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:47:33 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:47:33 INFO - Display Serial Number: 1600x1200 60 09:47:33 INFO - Main Display: Yes 09:47:33 INFO - Mirror: Off 09:47:33 INFO - Online: Yes 09:47:33 INFO - Rotation: Supported 09:47:33 INFO - Return code: 0 09:47:33 INFO - Running post-action listener: _resource_record_post_action 09:47:33 INFO - [mozharness: 2016-11-03 16:47:33.405202Z] Finished run-tests step (success) 09:47:33 INFO - Running post-run listener: _resource_record_post_run 09:47:33 INFO - Total resource usage - Wall time: 1209s; CPU: 54.0%; Read bytes: 1646592; Write bytes: 663570944; Read time: 10; Write time: 1874 09:47:33 INFO - TinderboxPrint: CPU usage
53.5% 09:47:33 INFO - TinderboxPrint: I/O read bytes / time
1,646,592 / 10 09:47:33 INFO - TinderboxPrint: I/O write bytes / time
663,570,944 / 1,874 09:47:33 INFO - TinderboxPrint: CPU idle
2,248.5 (46.5%) 09:47:33 INFO - TinderboxPrint: CPU system
969.5 (20.0%) 09:47:33 INFO - TinderboxPrint: CPU user
1,619.7 (33.5%) 09:47:33 INFO - TinderboxPrint: Swap in / out
365,043,712 / 0 09:47:33 INFO - install - Wall time: 32s; CPU: 55.0%; Read bytes: 360559104; Write bytes: 356738560; Read time: 27568; Write time: 735 09:47:33 INFO - run-tests - Wall time: 1177s; CPU: 53.0%; Read bytes: 774144; Write bytes: 295556096; Read time: 7; Write time: 1100 09:47:33 INFO - Running post-run listener: _upload_blobber_files 09:47:33 INFO - Blob upload gear active. 09:47:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:47:33 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 09:47:33 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'] 09:47:33 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 09:47:34 INFO - (blobuploader) - INFO - Open directory for files ... 09:47:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:47:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:47:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:47:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:47:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:47:35 INFO - (blobuploader) - INFO - Done attempting. 09:47:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:47:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:47:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:47:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:47:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:47:36 INFO - (blobuploader) - INFO - Done attempting. 09:47:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:47:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:47:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:47:38 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:47:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:47:38 INFO - (blobuploader) - INFO - Done attempting. 09:47:38 INFO - (blobuploader) - INFO - Iteration through files over. 09:47:38 INFO - Return code: 0 09:47:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:47:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:47:38 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b8d6ccb99d99499776642e464b31986ffafe2272715ddbe4dae80975db6a6637cef5a8876063812333d9763ab5be18f651e9151064e07cef14329418ff678dee", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9e03ccd3c1345f01bfeb4cd245fb1ab2841d8bd26305a7a1008605e039284fe6a18b2470c7af716c68023db1b09f61149ca3f7437b1f07c5ebe513258dff98c3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/108b2e3700f6f107aeeeec1b3bdfb92e4aab1eebacb864ec59255ae6620176ff8d0bbfae4c89a786d32cd0263a7fb94c20d62629a39b29767a25708b8d145447"} 09:47:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:47:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:47:38 INFO - Contents: 09:47:38 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b8d6ccb99d99499776642e464b31986ffafe2272715ddbe4dae80975db6a6637cef5a8876063812333d9763ab5be18f651e9151064e07cef14329418ff678dee", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9e03ccd3c1345f01bfeb4cd245fb1ab2841d8bd26305a7a1008605e039284fe6a18b2470c7af716c68023db1b09f61149ca3f7437b1f07c5ebe513258dff98c3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/108b2e3700f6f107aeeeec1b3bdfb92e4aab1eebacb864ec59255ae6620176ff8d0bbfae4c89a786d32cd0263a7fb94c20d62629a39b29767a25708b8d145447"} 09:47:38 INFO - Running post-run listener: copy_logs_to_upload_dir 09:47:38 INFO - Copying logs to upload dir... 09:47:38 INFO - mkdir: /builds/slave/test/build/upload/logs 09:47:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.935273 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-11-03 09:47:38.583023) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-03 09:47:38.586251) ========= 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.HXOxP4PXz2/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.3HzMKOHxr8/Listeners TMPDIR=/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/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/b8d6ccb99d99499776642e464b31986ffafe2272715ddbe4dae80975db6a6637cef5a8876063812333d9763ab5be18f651e9151064e07cef14329418ff678dee", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9e03ccd3c1345f01bfeb4cd245fb1ab2841d8bd26305a7a1008605e039284fe6a18b2470c7af716c68023db1b09f61149ca3f7437b1f07c5ebe513258dff98c3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/108b2e3700f6f107aeeeec1b3bdfb92e4aab1eebacb864ec59255ae6620176ff8d0bbfae4c89a786d32cd0263a7fb94c20d62629a39b29767a25708b8d145447"} build_url:https://queue.taskcluster.net/v1/task/Ih8HRY3cQJ60r4IrY3xr0Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011175 build_url: 'https://queue.taskcluster.net/v1/task/Ih8HRY3cQJ60r4IrY3xr0Q/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/b8d6ccb99d99499776642e464b31986ffafe2272715ddbe4dae80975db6a6637cef5a8876063812333d9763ab5be18f651e9151064e07cef14329418ff678dee", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9e03ccd3c1345f01bfeb4cd245fb1ab2841d8bd26305a7a1008605e039284fe6a18b2470c7af716c68023db1b09f61149ca3f7437b1f07c5ebe513258dff98c3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/108b2e3700f6f107aeeeec1b3bdfb92e4aab1eebacb864ec59255ae6620176ff8d0bbfae4c89a786d32cd0263a7fb94c20d62629a39b29767a25708b8d145447"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-03 09:47:38.621325) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-03 09:47:38.621664) ========= 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.HXOxP4PXz2/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.3HzMKOHxr8/Listeners TMPDIR=/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/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.005358 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-03 09:47:38.670717) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-03 09:47:38.671062) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-03 09:47:38.671387) ========= ========= Total master_lag: 0.19 =========