builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0026 starttime: 1476362702.24 results: success (0) buildid: 20161013032424 builduid: fab1b2cdfab8430bb8d5a7564ad32cad revision: a36fb6876e49d6cd19b8f0e7fc22f84a6433a878 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-13 05:45:02.239916) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-13 05:45:02.240406) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-13 05:45:02.240705) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-13 05:45:02.265278) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 05:45:02.265712) ========= 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.N7ObjJ66Rn/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.ircv91anVk/Listeners TMPDIR=/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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-10-13 05:45:02-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 10.9M=0.001s 2016-10-13 05:45:02 (10.9 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.348348 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 05:45:02.636461) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 05:45:02.636777) ========= 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.N7ObjJ66Rn/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.ircv91anVk/Listeners TMPDIR=/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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.028023 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 05:45:02.685952) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-13 05:45:02.686298) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev a36fb6876e49d6cd19b8f0e7fc22f84a6433a878 --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 a36fb6876e49d6cd19b8f0e7fc22f84a6433a878 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.N7ObjJ66Rn/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.ircv91anVk/Listeners TMPDIR=/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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-10-13 05:45:02,762 truncating revision to first 12 chars 2016-10-13 05:45:02,762 Setting DEBUG logging. 2016-10-13 05:45:02,763 attempt 1/10 2016-10-13 05:45:02,763 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/a36fb6876e49?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-13 05:45:04,302 unpacking tar archive at: mozilla-aurora-a36fb6876e49/testing/mozharness/ program finished with exit code 0 elapsedTime=1.807636 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-13 05:45:04.516538) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-13 05:45:04.517143) ========= script_repo_revision: a36fb6876e49d6cd19b8f0e7fc22f84a6433a878 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-13 05:45:04.517568) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-13 05:45:04.517905) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-13 05:45:04.536611) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-10-13 05:45:04.537093) ========= /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.N7ObjJ66Rn/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.ircv91anVk/Listeners TMPDIR=/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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 05:45:04 INFO - MultiFileLogger online at 20161013 05:45:04 in /builds/slave/test 05:45:04 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 05:45:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:45:04 INFO - {'append_to_log': False, 05:45:04 INFO - 'base_work_dir': '/builds/slave/test', 05:45:04 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 05:45:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:45:04 INFO - 'branch': 'Mozilla-Aurora', 05:45:04 INFO - 'buildbot_json_path': 'buildprops.json', 05:45:04 INFO - 'config_files': ('talos/mac_config.py',), 05:45:04 INFO - 'default_actions': ('clobber', 05:45:04 INFO - 'read-buildbot-config', 05:45:04 INFO - 'download-and-extract', 05:45:04 INFO - 'populate-webroot', 05:45:04 INFO - 'create-virtualenv', 05:45:04 INFO - 'install', 05:45:04 INFO - 'run-tests'), 05:45:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:45:04 INFO - 'download_minidump_stackwalk': True, 05:45:04 INFO - 'download_symbols': 'ondemand', 05:45:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:45:04 INFO - 'tooltool.py': '/tools/tooltool.py', 05:45:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:45:04 INFO - '/tools/misc-python/virtualenv.py')}, 05:45:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:45:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:45:04 INFO - 'installer_path': 'installer.exe', 05:45:04 INFO - 'log_level': 'info', 05:45:04 INFO - 'log_name': 'talos', 05:45:04 INFO - 'log_to_console': True, 05:45:04 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:45:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:45:04 INFO - 'opt_config_files': (), 05:45:04 INFO - 'pip_index': False, 05:45:04 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:45:04 INFO - 'cmd': ('bash', 05:45:04 INFO - '-c', 05:45:04 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:45:04 INFO - 'enabled': True, 05:45:04 INFO - 'halt_on_failure': False, 05:45:04 INFO - 'name': 'check_screen_resolution'},), 05:45:04 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:45:04 INFO - 'cmd': ('bash', 05:45:04 INFO - '-c', 05:45:04 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:45:04 INFO - 'enabled': True, 05:45:04 INFO - 'halt_on_failure': False, 05:45:04 INFO - 'name': 'check_screen_resolution'},), 05:45:04 INFO - 'run_cmd_checks_enabled': True, 05:45:04 INFO - 'sps_profile': False, 05:45:04 INFO - 'sps_profile_interval': 0, 05:45:04 INFO - 'suite': 'dromaeojs', 05:45:04 INFO - 'system_bits': '32', 05:45:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:45:04 INFO - 'title': 't-yosemite-r7-0026', 05:45:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:45:04 INFO - 'use_talos_json': True, 05:45:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:45:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:45:04 INFO - 'work_dir': 'build'} 05:45:04 INFO - [mozharness: 2016-10-13 12:45:04.737105Z] Running clobber step. 05:45:04 INFO - Running pre-action listener: _resource_record_pre_action 05:45:04 INFO - Running main action method: clobber 05:45:04 INFO - rmtree: /builds/slave/test/build 05:45:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:45:07 INFO - Running post-action listener: _resource_record_post_action 05:45:07 INFO - [mozharness: 2016-10-13 12:45:07.038928Z] Finished clobber step (success) 05:45:07 INFO - [mozharness: 2016-10-13 12:45:07.039052Z] Running read-buildbot-config step. 05:45:07 INFO - Running pre-action listener: _resource_record_pre_action 05:45:07 INFO - Running main action method: read_buildbot_config 05:45:07 INFO - Using buildbot properties: 05:45:07 INFO - { 05:45:07 INFO - "project": "", 05:45:07 INFO - "product": "firefox", 05:45:07 INFO - "script_repo_revision": "production", 05:45:07 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 05:45:07 INFO - "repository": "", 05:45:07 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 05:45:07 INFO - "buildid": "20161013032424", 05:45:07 INFO - "pgo_build": "False", 05:45:07 INFO - "basedir": "/builds/slave/test", 05:45:07 INFO - "buildnumber": 7, 05:45:07 INFO - "slavename": "t-yosemite-r7-0026", 05:45:07 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 05:45:07 INFO - "platform": "yosemite_r7", 05:45:07 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 05:45:07 INFO - "branch": "mozilla-aurora", 05:45:07 INFO - "repo_path": "releases/mozilla-aurora", 05:45:07 INFO - "revision": "a36fb6876e49d6cd19b8f0e7fc22f84a6433a878", 05:45:07 INFO - "stage_platform": "macosx64", 05:45:07 INFO - "builduid": "fab1b2cdfab8430bb8d5a7564ad32cad", 05:45:07 INFO - "slavebuilddir": "test" 05:45:07 INFO - } 05:45:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/PNg4obGWRdmfeP-cK4RCnQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 05:45:07 INFO - Running post-action listener: _resource_record_post_action 05:45:07 INFO - [mozharness: 2016-10-13 12:45:07.042506Z] Finished read-buildbot-config step (success) 05:45:07 INFO - [mozharness: 2016-10-13 12:45:07.042638Z] Running download-and-extract step. 05:45:07 INFO - Running pre-action listener: _resource_record_pre_action 05:45:07 INFO - Running main action method: download_and_extract 05:45:07 INFO - mkdir: /builds/slave/test/build/tests 05:45:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:45:07 INFO - trying https://queue.taskcluster.net/v1/task/PNg4obGWRdmfeP-cK4RCnQ/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 05:45:07 INFO - Downloading https://queue.taskcluster.net/v1/task/PNg4obGWRdmfeP-cK4RCnQ/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 05:45:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PNg4obGWRdmfeP-cK4RCnQ/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 05:45:08 INFO - Downloaded 1199 bytes. 05:45:08 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 05:45:08 INFO - Using the following test package requirements: 05:45:08 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 05:45:08 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 05:45:08 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 05:45:08 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 05:45:08 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 05:45:08 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 05:45:08 INFO - u'jsshell-mac.zip'], 05:45:08 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 05:45:08 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 05:45:08 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 05:45:08 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 05:45:08 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 05:45:08 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 05:45:08 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 05:45:08 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 05:45:08 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 05:45:08 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 05:45:08 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 05:45:08 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 05:45:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PNg4obGWRdmfeP-cK4RCnQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 05:45:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PNg4obGWRdmfeP-cK4RCnQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 05:45:08 INFO - Fetch https://queue.taskcluster.net/v1/task/PNg4obGWRdmfeP-cK4RCnQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 05:45:08 INFO - Expected file size: 16435277 05:45:16 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 05:45:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PNg4obGWRdmfeP-cK4RCnQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 05:45:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PNg4obGWRdmfeP-cK4RCnQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 05:45:16 INFO - Fetch https://queue.taskcluster.net/v1/task/PNg4obGWRdmfeP-cK4RCnQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 05:45:16 INFO - Expected file size: 16435277 05:45:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PNg4obGWRdmfeP-cK4RCnQ/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 05:45:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PNg4obGWRdmfeP-cK4RCnQ/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 05:45:23 INFO - Fetch https://queue.taskcluster.net/v1/task/PNg4obGWRdmfeP-cK4RCnQ/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 05:45:24 INFO - Expected file size: 14414059 05:45:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:45:25 INFO - trying https://queue.taskcluster.net/v1/task/PNg4obGWRdmfeP-cK4RCnQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 05:45:25 INFO - Downloading https://queue.taskcluster.net/v1/task/PNg4obGWRdmfeP-cK4RCnQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 05:45:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PNg4obGWRdmfeP-cK4RCnQ/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 05:45:28 INFO - Downloaded 115366167 bytes. 05:45:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PNg4obGWRdmfeP-cK4RCnQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 05:45:28 INFO - mkdir: /builds/slave/test/properties 05:45:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:45:28 INFO - Writing to file /builds/slave/test/properties/build_url 05:45:28 INFO - Contents: 05:45:28 INFO - build_url:https://queue.taskcluster.net/v1/task/PNg4obGWRdmfeP-cK4RCnQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 05:45:28 INFO - Running post-action listener: _resource_record_post_action 05:45:28 INFO - Running post-action listener: set_extra_try_arguments 05:45:28 INFO - [mozharness: 2016-10-13 12:45:28.973541Z] Finished download-and-extract step (success) 05:45:28 INFO - [mozharness: 2016-10-13 12:45:28.973652Z] Running populate-webroot step. 05:45:28 INFO - Running pre-action listener: _resource_record_pre_action 05:45:28 INFO - Running main action method: populate_webroot 05:45:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:45:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:45:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:45:28 INFO - '--tppagecycles', 05:45:28 INFO - '7'], 05:45:28 INFO - 'tests': ['tsvgm']}}, 05:45:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:45:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:45:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:45:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:45:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:45:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:45:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:28 INFO - 'talos_options': ['--disable-e10s'], 05:45:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:45:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:45:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:28 INFO - 'talos_options': ['--disable-e10s'], 05:45:28 INFO - 'tests': ['damp', 'tps']}, 05:45:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:28 INFO - 'tests': ['damp', 'tps']}, 05:45:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:45:28 INFO - 'tests': ['dromaeo_dom']}, 05:45:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:45:28 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:45:28 INFO - 'tests': ['basic_compositor_video']}, 05:45:28 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:45:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:45:28 INFO - 'tests': ['a11yr', 05:45:28 INFO - 'ts_paint', 05:45:28 INFO - 'tpaint', 05:45:28 INFO - 'sessionrestore', 05:45:28 INFO - 'sessionrestore_no_auto_restore', 05:45:28 INFO - 'tabpaint']}, 05:45:28 INFO - 'other-e10s': {'tests': ['a11yr', 05:45:28 INFO - 'ts_paint', 05:45:28 INFO - 'tpaint', 05:45:28 INFO - 'sessionrestore', 05:45:28 INFO - 'sessionrestore_no_auto_restore', 05:45:28 INFO - 'tabpaint']}, 05:45:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:45:28 INFO - 'ts_paint', 05:45:28 INFO - 'tpaint', 05:45:28 INFO - 'sessionrestore', 05:45:28 INFO - 'sessionrestore_no_auto_restore', 05:45:28 INFO - 'tabpaint']}, 05:45:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:45:28 INFO - 'ts_paint', 05:45:28 INFO - 'tpaint', 05:45:28 INFO - 'sessionrestore', 05:45:28 INFO - 'sessionrestore_no_auto_restore', 05:45:28 INFO - 'tabpaint']}, 05:45:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:45:28 INFO - 'tests': ['a11yr', 05:45:28 INFO - 'ts_paint', 05:45:28 INFO - 'tpaint', 05:45:28 INFO - 'sessionrestore', 05:45:28 INFO - 'sessionrestore_no_auto_restore', 05:45:28 INFO - 'tabpaint']}, 05:45:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:45:28 INFO - 'tests': ['a11yr', 05:45:28 INFO - 'ts_paint', 05:45:28 INFO - 'tpaint', 05:45:28 INFO - 'sessionrestore', 05:45:28 INFO - 'sessionrestore_no_auto_restore', 05:45:28 INFO - 'tabpaint']}, 05:45:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:45:28 INFO - 'tests': ['tsvgx', 05:45:28 INFO - 'tsvgr_opacity', 05:45:28 INFO - 'tart', 05:45:28 INFO - 'tscrollx', 05:45:28 INFO - 'cart']}, 05:45:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:45:28 INFO - 'tsvgr_opacity', 05:45:28 INFO - 'tart', 05:45:28 INFO - 'tscrollx', 05:45:28 INFO - 'cart']}, 05:45:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:28 INFO - 'talos_options': ['--disable-e10s'], 05:45:28 INFO - 'tests': ['tp5o']}, 05:45:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:28 INFO - 'tests': ['tp5o']}, 05:45:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:28 INFO - 'talos_options': ['--disable-e10s', 05:45:28 INFO - '--xperf_path', 05:45:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:45:28 INFO - 'tests': ['tp5n']}, 05:45:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:28 INFO - 'talos_options': ['--xperf_path', 05:45:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:45:28 INFO - 'tests': ['tp5n']}}, 05:45:28 INFO - 'talos.zip': {'path': '', 05:45:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:45:28 INFO - Running post-action listener: _resource_record_post_action 05:45:28 INFO - [mozharness: 2016-10-13 12:45:28.992645Z] Finished populate-webroot step (success) 05:45:28 INFO - [mozharness: 2016-10-13 12:45:28.992773Z] Running create-virtualenv step. 05:45:28 INFO - Running pre-action listener: _resource_record_pre_action 05:45:28 INFO - Running main action method: create_virtualenv 05:45:28 INFO - Creating virtualenv /builds/slave/test/build/venv 05:45:28 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 05:45:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:45:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:45:29 INFO - Using real prefix '/tools/python27' 05:45:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:45:29 INFO - Installing distribute.............................................................................................................................................................................................done. 05:45:32 INFO - Installing pip.................done. 05:45:32 INFO - Return code: 0 05:45:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:45: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')]} 05:45:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45: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')]} 05:45:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:32 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 0x10c5bc490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c532570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e095abb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c3d0d30>, '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 0x10c236db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c3c8b20>, '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.N7ObjJ66Rn/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.ircv91anVk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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 05:45:32 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 05:45:32 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 05:45:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.N7ObjJ66Rn/Render', 05:45:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:45:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:45:32 INFO - 'HOME': '/Users/cltbld', 05:45:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:45:32 INFO - 'LOGNAME': 'cltbld', 05:45:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:32 INFO - 'MOZ_NO_REMOTE': '1', 05:45:32 INFO - 'NO_EM_RESTART': '1', 05:45:32 INFO - 'PAGER': '/bin/cat', 05:45:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:45:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:45:32 INFO - 'PWD': '/builds/slave/test', 05:45:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:45:32 INFO - 'SHELL': '/bin/bash', 05:45:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ircv91anVk/Listeners', 05:45:32 INFO - 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', 05:45:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:45:32 INFO - 'USER': 'cltbld', 05:45:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:45:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:45:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:32 INFO - 'XPC_FLAGS': '0x0', 05:45:32 INFO - 'XPC_SERVICE_NAME': '0', 05:45:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:45:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:32 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 05:45:32 INFO - Cleaning up... 05:45:32 INFO - Return code: 0 05:45:32 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:45: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')]} 05:45:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45: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')]} 05:45:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:32 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 0x10c5bc490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c532570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e095abb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c3d0d30>, '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 0x10c236db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c3c8b20>, '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.N7ObjJ66Rn/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.ircv91anVk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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 05:45:32 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 05:45:32 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 05:45:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.N7ObjJ66Rn/Render', 05:45:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:45:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:45:32 INFO - 'HOME': '/Users/cltbld', 05:45:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:45:32 INFO - 'LOGNAME': 'cltbld', 05:45:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:32 INFO - 'MOZ_NO_REMOTE': '1', 05:45:32 INFO - 'NO_EM_RESTART': '1', 05:45:32 INFO - 'PAGER': '/bin/cat', 05:45:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:45:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:45:32 INFO - 'PWD': '/builds/slave/test', 05:45:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:45:32 INFO - 'SHELL': '/bin/bash', 05:45:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ircv91anVk/Listeners', 05:45:32 INFO - 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', 05:45:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:45:32 INFO - 'USER': 'cltbld', 05:45:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:45:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:45:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:32 INFO - 'XPC_FLAGS': '0x0', 05:45:32 INFO - 'XPC_SERVICE_NAME': '0', 05:45:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:45:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:33 INFO - Downloading/unpacking psutil>=3.1.1 05:45:33 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 05:45:33 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 05:45:33 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 05:45:33 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 05:45:33 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 05:45:33 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 05:45:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:45:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:45:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:45:36 INFO - Installing collected packages: psutil 05:45:36 INFO - Running setup.py install for psutil 05:45:36 INFO - building 'psutil._psutil_osx' extension 05:45:36 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 05:45:37 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 05:45:37 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 05:45:37 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 05:45:37 INFO - building 'psutil._psutil_posix' extension 05:45:37 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 05:45:37 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:45:37 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:45:37 INFO - ^ 05:45:37 INFO - 1 warning generated. 05:45:37 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 05:45:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:45:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:45:37 INFO - Successfully installed psutil 05:45:37 INFO - Cleaning up... 05:45:37 INFO - Return code: 0 05:45:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:45:37 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')]} 05:45:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:37 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')]} 05:45:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:37 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 0x10c5bc490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c532570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e095abb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c3d0d30>, '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 0x10c236db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c3c8b20>, '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.N7ObjJ66Rn/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.ircv91anVk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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 05:45:37 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 05:45:37 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 05:45:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.N7ObjJ66Rn/Render', 05:45:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:45:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:45:37 INFO - 'HOME': '/Users/cltbld', 05:45:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:45:37 INFO - 'LOGNAME': 'cltbld', 05:45:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:37 INFO - 'MOZ_NO_REMOTE': '1', 05:45:37 INFO - 'NO_EM_RESTART': '1', 05:45:37 INFO - 'PAGER': '/bin/cat', 05:45:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:45:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:45:37 INFO - 'PWD': '/builds/slave/test', 05:45:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:45:37 INFO - 'SHELL': '/bin/bash', 05:45:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ircv91anVk/Listeners', 05:45:37 INFO - 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', 05:45:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:45:37 INFO - 'USER': 'cltbld', 05:45:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:45:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:45:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:37 INFO - 'XPC_FLAGS': '0x0', 05:45:37 INFO - 'XPC_SERVICE_NAME': '0', 05:45:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:45:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:45:37 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 05:45:37 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 05:45:37 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 05:45:37 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 05:45:37 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 05:45:37 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 05:45:40 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:45:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:45:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:45:40 INFO - Installing collected packages: mozsystemmonitor 05:45:40 INFO - Running setup.py install for mozsystemmonitor 05:45:40 INFO - Successfully installed mozsystemmonitor 05:45:40 INFO - Cleaning up... 05:45:40 INFO - Return code: 0 05:45:40 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:45:40 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')]} 05:45:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:40 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')]} 05:45:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:40 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 0x10c5bc490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c532570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e095abb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c3d0d30>, '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 0x10c236db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c3c8b20>, '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.N7ObjJ66Rn/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.ircv91anVk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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 05:45:40 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 05:45:40 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 05:45:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.N7ObjJ66Rn/Render', 05:45:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:45:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:45:40 INFO - 'HOME': '/Users/cltbld', 05:45:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:45:40 INFO - 'LOGNAME': 'cltbld', 05:45:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:40 INFO - 'MOZ_NO_REMOTE': '1', 05:45:40 INFO - 'NO_EM_RESTART': '1', 05:45:40 INFO - 'PAGER': '/bin/cat', 05:45:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:45:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:45:40 INFO - 'PWD': '/builds/slave/test', 05:45:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:45:40 INFO - 'SHELL': '/bin/bash', 05:45:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ircv91anVk/Listeners', 05:45:40 INFO - 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', 05:45:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:45:40 INFO - 'USER': 'cltbld', 05:45:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:45:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:45:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:40 INFO - 'XPC_FLAGS': '0x0', 05:45:40 INFO - 'XPC_SERVICE_NAME': '0', 05:45:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:45:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:40 INFO - Downloading/unpacking jsonschema==2.5.1 05:45:40 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 05:45:40 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 05:45:40 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 05:45:40 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 05:45:40 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 05:45:40 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 05:45:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:45:43 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:45:43 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 05:45:43 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 05:45:43 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 05:45:43 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 05:45:43 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 05:45:43 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 05:45:43 INFO - Downloading functools32-3.2.3-2.tar.gz 05:45:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:45:43 INFO - warning: no files found matching '*.txt' 05:45:43 INFO - no previously-included directories found matching 'build' 05:45:43 INFO - no previously-included directories found matching 'dist' 05:45:43 INFO - no previously-included directories found matching '.git*' 05:45:43 INFO - Installing collected packages: jsonschema, functools32 05:45:44 INFO - Running setup.py install for functools32 05:45:44 INFO - warning: no files found matching '*.txt' 05:45:44 INFO - no previously-included directories found matching 'build' 05:45:44 INFO - no previously-included directories found matching 'dist' 05:45:44 INFO - no previously-included directories found matching '.git*' 05:45:44 INFO - Successfully installed jsonschema functools32 05:45:44 INFO - Cleaning up... 05:45:44 INFO - Return code: 0 05:45:44 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:45:44 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')]} 05:45:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:44 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')]} 05:45:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:44 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 0x10c5bc490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c532570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e095abb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c3d0d30>, '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 0x10c236db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c3c8b20>, '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.N7ObjJ66Rn/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.ircv91anVk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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 05:45:44 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 05:45:44 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 05:45:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.N7ObjJ66Rn/Render', 05:45:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:45:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:45:44 INFO - 'HOME': '/Users/cltbld', 05:45:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:45:44 INFO - 'LOGNAME': 'cltbld', 05:45:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:44 INFO - 'MOZ_NO_REMOTE': '1', 05:45:44 INFO - 'NO_EM_RESTART': '1', 05:45:44 INFO - 'PAGER': '/bin/cat', 05:45:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:45:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:45:44 INFO - 'PWD': '/builds/slave/test', 05:45:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:45:44 INFO - 'SHELL': '/bin/bash', 05:45:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ircv91anVk/Listeners', 05:45:44 INFO - 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', 05:45:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:45:44 INFO - 'USER': 'cltbld', 05:45:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:45:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:45:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:44 INFO - 'XPC_FLAGS': '0x0', 05:45:44 INFO - 'XPC_SERVICE_NAME': '0', 05:45:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:45:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:44 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:45:44 INFO - Cleaning up... 05:45:44 INFO - Return code: 0 05:45:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:45:44 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')]} 05:45:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:44 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')]} 05:45:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:44 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 0x10c5bc490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c532570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e095abb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c3d0d30>, '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 0x10c236db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c3c8b20>, '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.N7ObjJ66Rn/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.ircv91anVk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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 05:45:44 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 05:45:44 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 05:45:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.N7ObjJ66Rn/Render', 05:45:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:45:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:45:44 INFO - 'HOME': '/Users/cltbld', 05:45:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:45:44 INFO - 'LOGNAME': 'cltbld', 05:45:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:44 INFO - 'MOZ_NO_REMOTE': '1', 05:45:44 INFO - 'NO_EM_RESTART': '1', 05:45:44 INFO - 'PAGER': '/bin/cat', 05:45:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:45:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:45:44 INFO - 'PWD': '/builds/slave/test', 05:45:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:45:44 INFO - 'SHELL': '/bin/bash', 05:45:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ircv91anVk/Listeners', 05:45:44 INFO - 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', 05:45:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:45:44 INFO - 'USER': 'cltbld', 05:45:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:45:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:45:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:44 INFO - 'XPC_FLAGS': '0x0', 05:45:44 INFO - 'XPC_SERVICE_NAME': '0', 05:45:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:45:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:44 INFO - Downloading/unpacking blobuploader==1.2.4 05:45:44 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 05:45:44 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 05:45:44 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 05:45:44 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 05:45:44 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 05:45:44 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 05:45:47 INFO - Downloading blobuploader-1.2.4.tar.gz 05:45:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:45:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:45:47 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 05:45:47 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 05:45:47 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 05:45:47 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 05:45:47 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 05:45:47 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 05:45:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:45:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:45:48 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 05:45:48 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 05:45:48 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 05:45:48 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 05:45:48 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 05:45:48 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 05:45:48 INFO - Downloading docopt-0.6.1.tar.gz 05:45:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:45:48 INFO - Installing collected packages: blobuploader, requests, docopt 05:45:48 INFO - Running setup.py install for blobuploader 05:45:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:45:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:45:48 INFO - Running setup.py install for requests 05:45:49 INFO - Running setup.py install for docopt 05:45:49 INFO - Successfully installed blobuploader requests docopt 05:45:49 INFO - Cleaning up... 05:45:49 INFO - Return code: 0 05:45:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:45: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')]} 05:45:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45: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')]} 05:45:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:49 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 0x10c5bc490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c532570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e095abb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c3d0d30>, '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 0x10c236db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c3c8b20>, '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.N7ObjJ66Rn/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.ircv91anVk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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 05:45:49 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 05:45:49 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 05:45:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.N7ObjJ66Rn/Render', 05:45:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:45:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:45:49 INFO - 'HOME': '/Users/cltbld', 05:45:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:45:49 INFO - 'LOGNAME': 'cltbld', 05:45:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:49 INFO - 'MOZ_NO_REMOTE': '1', 05:45:49 INFO - 'NO_EM_RESTART': '1', 05:45:49 INFO - 'PAGER': '/bin/cat', 05:45:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:45:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:45:49 INFO - 'PWD': '/builds/slave/test', 05:45:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:45:49 INFO - 'SHELL': '/bin/bash', 05:45:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ircv91anVk/Listeners', 05:45:49 INFO - 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', 05:45:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:45:49 INFO - 'USER': 'cltbld', 05:45:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:45:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:45:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:49 INFO - 'XPC_FLAGS': '0x0', 05:45:49 INFO - 'XPC_SERVICE_NAME': '0', 05:45:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:45:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:45:49 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-iIvrYz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:45:49 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-hS2XNl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:45:49 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-5tC2Pl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:45:50 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-182Q6q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:45:50 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-qGKxWg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:45:50 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-ekHLUC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:45:50 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-Y7gbhX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:45:50 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-ibGpVy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:45:50 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-JtqIlB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:45:50 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-Zl2kni-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:45:50 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-QjAhCT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:45:50 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-CdfsDF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:45:50 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-Abg5G1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:45:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:45:51 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-pTv9a_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:45:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:45:51 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-vYSGfw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:45:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:45:51 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-wTHUIS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:45:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:45:51 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-7Ye7uQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:45:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:45:51 INFO - Running setup.py install for manifestparser 05:45:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:45:51 INFO - Running setup.py install for mozcrash 05:45:51 INFO - Running setup.py install for mozdebug 05:45:51 INFO - Running setup.py install for mozdevice 05:45:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:45:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:45:52 INFO - Running setup.py install for mozfile 05:45:52 INFO - Running setup.py install for mozhttpd 05:45:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:45:52 INFO - Running setup.py install for mozinfo 05:45:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:45:52 INFO - Running setup.py install for mozInstall 05:45:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:45:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:45:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:45:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:45:52 INFO - Running setup.py install for mozleak 05:45:52 INFO - Running setup.py install for mozlog 05:45:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:45:52 INFO - Running setup.py install for moznetwork 05:45:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:45:53 INFO - Running setup.py install for mozprocess 05:45:53 INFO - Running setup.py install for mozprofile 05:45:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:45:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:45:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:45:53 INFO - Running setup.py install for mozrunner 05:45:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:45:53 INFO - Running setup.py install for mozscreenshot 05:45:53 INFO - Running setup.py install for moztest 05:45:53 INFO - Running setup.py install for mozversion 05:45:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:45:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:45:54 INFO - Cleaning up... 05:45:54 INFO - Return code: 0 05:45:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:45:54 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')]} 05:45:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:54 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')]} 05:45:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:54 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 0x10c5bc490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c532570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e095abb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c3d0d30>, '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 0x10c236db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c3c8b20>, '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.N7ObjJ66Rn/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.ircv91anVk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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 05:45:54 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 05:45:54 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 05:45:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.N7ObjJ66Rn/Render', 05:45:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:45:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:45:54 INFO - 'HOME': '/Users/cltbld', 05:45:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:45:54 INFO - 'LOGNAME': 'cltbld', 05:45:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:54 INFO - 'MOZ_NO_REMOTE': '1', 05:45:54 INFO - 'NO_EM_RESTART': '1', 05:45:54 INFO - 'PAGER': '/bin/cat', 05:45:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:45:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:45:54 INFO - 'PWD': '/builds/slave/test', 05:45:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:45:54 INFO - 'SHELL': '/bin/bash', 05:45:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ircv91anVk/Listeners', 05:45:54 INFO - 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', 05:45:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:45:54 INFO - 'USER': 'cltbld', 05:45:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:45:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:45:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:54 INFO - 'XPC_FLAGS': '0x0', 05:45:54 INFO - 'XPC_SERVICE_NAME': '0', 05:45:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:45:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:45:54 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-SskiF5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:45:54 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)) 05:45:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:45:54 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-5Bs_YJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:45:54 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)) 05:45:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:45:54 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-XAlJ49-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:45:54 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)) 05:45:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:45:54 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-VDwIpV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:45:54 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)) 05:45:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:45:54 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-ZUcc3g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:45:54 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)) 05:45:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:45:54 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-RuhI51-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:45:54 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)) 05:45:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:45:54 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-8Mswa8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:45:55 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)) 05:45:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:45:55 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-9HO6Ra-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:45:55 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)) 05:45:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:45:55 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-PpJ7tv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:45:55 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)) 05:45:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:45:55 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-FNtIWr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:45:55 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)) 05:45:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:45:55 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-NkVCuB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:45:55 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)) 05:45:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:45:55 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-Nk_1HP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:45:55 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)) 05:45:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:45:55 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-jtAsRw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:45:55 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)) 05:45:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:45:55 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-JXWtl6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:45:55 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)) 05:45:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:45:55 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-gHEtY7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:45:55 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)) 05:45:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:45:55 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-LjxAKl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:45:56 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)) 05:45:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:45:56 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-AwkrxY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:45:56 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)) 05:45:56 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)) 05:45:56 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)) 05:45:56 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)) 05:45:56 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)) 05:45:56 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)) 05:45:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:45:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:58 INFO - Downloading blessings-1.6.tar.gz 05:45:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:45:58 INFO - Installing collected packages: blessings 05:45:58 INFO - Running setup.py install for blessings 05:45:58 INFO - Successfully installed blessings 05:45:58 INFO - Cleaning up... 05:45:58 INFO - Return code: 0 05:45:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:45:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:45:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:45:59 INFO - Reading from file tmpfile_stdout 05:45:59 INFO - Current package versions: 05:45:59 INFO - blessings == 1.6 05:45:59 INFO - blobuploader == 1.2.4 05:45:59 INFO - docopt == 0.6.1 05:45:59 INFO - functools32 == 3.2.3-2 05:45:59 INFO - jsonschema == 2.5.1 05:45:59 INFO - manifestparser == 1.1 05:45:59 INFO - mozInstall == 1.12 05:45:59 INFO - mozcrash == 0.17 05:45:59 INFO - mozdebug == 0.1 05:45:59 INFO - mozdevice == 0.48 05:45:59 INFO - mozfile == 1.2 05:45:59 INFO - mozhttpd == 0.7 05:45:59 INFO - mozinfo == 0.9 05:45:59 INFO - mozleak == 0.1 05:45:59 INFO - mozlog == 3.4 05:45:59 INFO - moznetwork == 0.27 05:45:59 INFO - mozprocess == 0.23 05:45:59 INFO - mozprofile == 0.28 05:45:59 INFO - mozrunner == 6.12 05:45:59 INFO - mozscreenshot == 0.1 05:45:59 INFO - mozsystemmonitor == 0.3 05:45:59 INFO - moztest == 0.7 05:45:59 INFO - mozversion == 1.4 05:45:59 INFO - psutil == 3.1.1 05:45:59 INFO - requests == 1.2.3 05:45:59 INFO - wsgiref == 0.1.2 05:45:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:45:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:45:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:45:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:59 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 0x10c5bc490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c532570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e095abb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c3d0d30>, '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 0x10c236db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c3c8b20>, '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.N7ObjJ66Rn/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.ircv91anVk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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 05:45:59 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 05:45:59 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 05:45:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.N7ObjJ66Rn/Render', 05:45:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:45:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:45:59 INFO - 'HOME': '/Users/cltbld', 05:45:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:45:59 INFO - 'LOGNAME': 'cltbld', 05:45:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:59 INFO - 'MOZ_NO_REMOTE': '1', 05:45:59 INFO - 'NO_EM_RESTART': '1', 05:45:59 INFO - 'PAGER': '/bin/cat', 05:45:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:45:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:45:59 INFO - 'PWD': '/builds/slave/test', 05:45:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:45:59 INFO - 'SHELL': '/bin/bash', 05:45:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ircv91anVk/Listeners', 05:45:59 INFO - 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', 05:45:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:45:59 INFO - 'USER': 'cltbld', 05:45:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:45:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:45:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:59 INFO - 'XPC_FLAGS': '0x0', 05:45:59 INFO - 'XPC_SERVICE_NAME': '0', 05:45:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:46:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:00 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)) 05:46:00 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)) 05:46:00 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)) 05:46:00 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)) 05:46:00 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)) 05:46:00 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)) 05:46:00 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)) 05:46:00 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)) 05:46:00 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)) 05:46:00 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)) 05:46:00 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)) 05:46:00 INFO - Cleaning up... 05:46:00 INFO - Return code: 0 05:46:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:46:00 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')]} 05:46:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:00 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')]} 05:46:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:00 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 0x10c5bc490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c532570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e095abb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c3d0d30>, '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 0x10c236db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c3c8b20>, '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.N7ObjJ66Rn/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.ircv91anVk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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 05:46:00 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 05:46:00 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 05:46:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.N7ObjJ66Rn/Render', 05:46:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:46:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:46:00 INFO - 'HOME': '/Users/cltbld', 05:46:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:46:00 INFO - 'LOGNAME': 'cltbld', 05:46:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:00 INFO - 'MOZ_NO_REMOTE': '1', 05:46:00 INFO - 'NO_EM_RESTART': '1', 05:46:00 INFO - 'PAGER': '/bin/cat', 05:46:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:46:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:00 INFO - 'PWD': '/builds/slave/test', 05:46:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:46:00 INFO - 'SHELL': '/bin/bash', 05:46:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ircv91anVk/Listeners', 05:46:00 INFO - 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', 05:46:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:46:00 INFO - 'USER': 'cltbld', 05:46:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:46:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:46:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:00 INFO - 'XPC_FLAGS': '0x0', 05:46:00 INFO - 'XPC_SERVICE_NAME': '0', 05:46:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:46:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:00 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:46:00 INFO - Cleaning up... 05:46:00 INFO - Return code: 0 05:46:00 INFO - Running post-action listener: _resource_record_post_action 05:46:00 INFO - Running post-action listener: _start_resource_monitoring 05:46:00 INFO - Starting resource monitoring. 05:46:00 INFO - [mozharness: 2016-10-13 12:46:00.537896Z] Finished create-virtualenv step (success) 05:46:00 INFO - [mozharness: 2016-10-13 12:46:00.538874Z] Running install step. 05:46:00 INFO - Running pre-action listener: _resource_record_pre_action 05:46:00 INFO - Running main action method: install 05:46:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:46:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:46:00 INFO - Reading from file tmpfile_stdout 05:46:00 INFO - Detecting whether we're running mozinstall >=1.0... 05:46:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:46:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:46:00 INFO - Reading from file tmpfile_stdout 05:46:00 INFO - Output received: 05:46:00 INFO - Usage: mozinstall [options] installer 05:46:00 INFO - Options: 05:46:00 INFO - -h, --help show this help message and exit 05:46:00 INFO - -d DEST, --destination=DEST 05:46:00 INFO - Directory to install application into. [default: 05:46:00 INFO - "/builds/slave/test"] 05:46:00 INFO - --app=APP Application being installed. [default: firefox] 05:46:00 INFO - mkdir: /builds/slave/test/build/application 05:46:00 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'] 05:46:00 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 05:46:33 INFO - Reading from file tmpfile_stdout 05:46:33 INFO - Output received: 05:46:33 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 05:46:33 INFO - Running post-action listener: _resource_record_post_action 05:46:33 INFO - [mozharness: 2016-10-13 12:46:33.139020Z] Finished install step (success) 05:46:33 INFO - [mozharness: 2016-10-13 12:46:33.139149Z] Running run-tests step. 05:46:33 INFO - Running pre-action listener: _resource_record_pre_action 05:46:33 INFO - Running main action method: run_tests 05:46:33 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:46:33 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:46:33 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:46:33 INFO - 2016-10-13 05:46:33.151 screenresolution[1644:7683] starting screenresolution argv=screenresolution get 05:46:33 INFO - 2016-10-13 05:46:33.154 screenresolution[1644:7683] Display 0: 1600x1200x32@60 05:46:33 INFO - 2016-10-13 05:46:33.158 screenresolution[1645:7686] starting screenresolution argv=screenresolution list 05:46:33 INFO - Available Modes on Display 0 05:46:33 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:46:33 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:46:33 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:46:33 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:46:33 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:46:33 INFO - Intel Iris: 05:46:33 INFO - Chipset Model: Intel Iris 05:46:33 INFO - Type: GPU 05:46:33 INFO - Bus: Built-In 05:46:33 INFO - VRAM (Dynamic, Max): 1536 MB 05:46:33 INFO - Vendor: Intel (0x8086) 05:46:33 INFO - Device ID: 0x0a2e 05:46:33 INFO - Revision ID: 0x0009 05:46:33 INFO - Displays: 05:46:33 INFO - Display: 05:46:33 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:46:33 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:46:33 INFO - Display Serial Number: 1600x1200 60 05:46:33 INFO - Main Display: Yes 05:46:33 INFO - Mirror: Off 05:46:33 INFO - Online: Yes 05:46:33 INFO - Rotation: Supported 05:46:33 INFO - Return code: 0 05:46:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:46:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:46:33 INFO - Python 2.7.3 05:46:33 INFO - Return code: 0 05:46:33 INFO - grabbing minidump binary from tooltool 05:46:33 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')]} 05:46:33 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 0x10c3d0d30>, '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 0x10c236db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c3c8b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:46:33 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 05:46:33 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 05:46:33 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 05:46:33 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:46:33 INFO - Return code: 0 05:46:33 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:46:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:46:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:46:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:46:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:46:33 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/PNg4obGWRdmfeP-cK4RCnQ/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0026', '--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 05:46:33 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/PNg4obGWRdmfeP-cK4RCnQ/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0026 --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 05:46:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.N7ObjJ66Rn/Render', 05:46:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:46:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:46:33 INFO - 'HOME': '/Users/cltbld', 05:46:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:46:33 INFO - 'LOGNAME': 'cltbld', 05:46:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:46:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:46:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:33 INFO - 'MOZ_NO_REMOTE': '1', 05:46:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:46:33 INFO - 'NO_EM_RESTART': '1', 05:46:33 INFO - 'PAGER': '/bin/cat', 05:46:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:46:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:33 INFO - 'PWD': '/builds/slave/test', 05:46:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:46:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:46:33 INFO - 'SHELL': '/bin/bash', 05:46:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ircv91anVk/Listeners', 05:46:33 INFO - 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', 05:46:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:46:33 INFO - 'USER': 'cltbld', 05:46:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:46:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:46:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:33 INFO - 'XPC_FLAGS': '0x0', 05:46:33 INFO - 'XPC_SERVICE_NAME': '0', 05:46:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:46:33 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/PNg4obGWRdmfeP-cK4RCnQ/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0026', '--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 05:46:33 INFO - mozversion application_buildid: 20161013032424 05:46:33 INFO - mozversion application_changeset: a36fb6876e49d6cd19b8f0e7fc22f84a6433a878 05:46:33 INFO - mozversion application_display_name: FirefoxDeveloperEdition 05:46:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:46:33 INFO - mozversion application_name: Firefox 05:46:33 INFO - mozversion application_remotingname: firefox-dev 05:46:33 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:46:33 INFO - mozversion application_vendor: Mozilla 05:46:33 INFO - mozversion application_version: 51.0a2 05:46:33 INFO - mozversion platform_buildid: 20161013032424 05:46:33 INFO - mozversion platform_changeset: a36fb6876e49d6cd19b8f0e7fc22f84a6433a878 05:46:33 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:46:33 INFO - mozversion platform_version: 51.0a2 05:46:33 INFO - using testdate: 1476362793 05:46:33 INFO - actual date: 1476362793 05:46:33 INFO - starting webserver on 'localhost:49267' 05:46:33 INFO - SUITE-START | Running 2 tests 05:46:33 INFO - TEST-START | dromaeo_css 05:46:33 INFO - operating with platform_type : mac_ 05:46:33 INFO - Initialising browser for dromaeo_css test... 05:46:33 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/tmpFhgxIN/profile http://localhost:49267/getInfo.html) 05:46:36 INFO - PROCESS | 1655 | __metrics Screen width/height:1600/1200 05:46:36 INFO - PROCESS | 1655 | colorDepth:24 05:46:36 INFO - PROCESS | 1655 | Browser inner width/height: 1024/689 05:46:36 INFO - PROCESS | 1655 | __metrics 05:46:36 INFO - PROCESS | 1655 | 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" 05:46:36 INFO - PROCESS | 1655 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:46:36 INFO - TEST-INFO | 1655: exit 0 05:46:36 INFO - Browser initialized. 05:46:36 INFO - Running cycle 1/1 for dromaeo_css test... 05:46:36 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/tmpFhgxIN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:46:48 INFO - PROCESS | 1657 | RSS: Main: 219389952 05:46:48 INFO - PROCESS | 1657 | 05:47:39 INFO - PROCESS | 1657 | 1476362859782 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] 05:49:51 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49267/tests/dromaeo/cssquery-ext.html) 05:49:53 INFO - PROCESS | 1657 | RSS: Main: 415657984 05:49:53 INFO - PROCESS | 1657 | 05:52:56 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-ext.html (next: http://localhost:49267/tests/dromaeo/cssquery-jquery.html) 05:52:56 INFO - PROCESS | 1657 | RSS: Main: 357306368 05:52:56 INFO - PROCESS | 1657 | 05:55:59 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49267/tests/dromaeo/cssquery-mootools.html) 05:55:59 INFO - PROCESS | 1657 | RSS: Main: 324141056 05:55:59 INFO - PROCESS | 1657 | 05:59:01 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49267/tests/dromaeo/cssquery-prototype.html) 05:59:02 INFO - PROCESS | 1657 | RSS: Main: 322310144 05:59:02 INFO - PROCESS | 1657 | 06:02:05 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49267/tests/dromaeo/cssquery-yui.html) 06:02:06 INFO - PROCESS | 1657 | RSS: Main: 314134528 06:02:06 INFO - PROCESS | 1657 | 06:05:09 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-yui.html (next: http://localhost:49267/tests/dromaeo/cssquery-dojo.html) 06:05:09 INFO - PROCESS | 1657 | RSS: Main: 364724224 06:05:09 INFO - PROCESS | 1657 | 06:05:09 INFO - PROCESS | 1657 | __start_tp_report 06:05:09 INFO - PROCESS | 1657 | _x_x_mozilla_page_load 06:05:09 INFO - PROCESS | 1657 | _x_x_mozilla_page_load_details 06:05:09 INFO - PROCESS | 1657 | |i|pagename|runs| 06:05:09 INFO - PROCESS | 1657 | |0;dojo.html;3337.065621625944;3337.249118948236;3369.629340772516;3374.4769560718096;3410.829458527073;5774.942250577493;5788.507976821965;5803.912941305878;5811.157382179592;5826.9708651456785;5755.971220143904;5779.826605201851;5858.76564937402;5862.091375836752;5876.11858221267;5167.741612919348;5217.034848553011;5275.525202731754;5296.073187192226;5307.73461326934;5199.272101905736;5221.086309895772;5225.947740522603;5327.094393953018;5331.786728530854;5238.240455134003;5316.9734151329385;5334.03987282289;5338.439463856297;5341.679499230039;5262.657927234755;5276.551493123089;5294.364676238837;5335.253064570963;5340.67955922642;5234.738263086831;5265.078611243017;5292.179712144623;5297.920531192035;5299.947000529984;5529.806456773994;5561.833145005616;5570.3315602128005;5658.207850900877;5784.305883294031;6252;6336.049592561107;6350;6354.459870910978;6378.712957916905;6320.873582528369;6362.586431881913;6376.776812811529;6377.553571250014;6393.9680301598655;5721.141828725725;5768.307803063659;5776.942230577724;5861.618994765369;5875.265591801025;6249.0626406039455;6289.433950944437;6332.715027823759;6345.428911397904;6345.460635846005;6222.595531290543;6229.190205273286;6236.812895613139;6249.187605611241;6257.092721555349;6200.968995154995;6206.751729930843;6386.776462823779;6393.648349340738;6414.903776443357;6133.785317513865;6136.280772554046;6168.9691551541955;6169.8457538561;6260.248770147611;6278.874422511524;6288.779892703734;6300.243970723543;6305.747770089237;6316.147320111818;4900.362952816183;4943.604511639061;4948.678335908155;4952.90094198114;4982.427020892571;4407.338899165086;4435.35687325336;4454.844080457168;4509.729416235036;4512.187806194851;5835.183074369592;5870.55970802183;5872.530197584183;5891.911621325684;5895.557833162444;5404.972975135099;6266.843328916813;6305.716242769086;6329.9872020476505;6340.7463701451425;5918.822435326947;5919.526437884959;5934.762609495659;5957.195778569924;5976.491998180203;5505.697186654773;5519.806806761744;5530.5299049580435;5530.723463826793;5536.723163841792;6233.34549872266;6264.060390941395;6316.968415157895;6362.936370636235;6388.5528013039575;6337.144485494584;6340.49276057905;6349.3650634937985;6378.617282963037;6401.93598064032;6359.459445947146;6365.172527571386;6367.363263673781;6370.74517019314;6384.744610215539;6138.051223665453;6143.662098584621;6307.400796924285;6310.6529140895855;6316.368363163647;6032.939670603238;6185.752569897154;6276.246850377984;6294.464970477377;6338.207724034496;6135.969320153371;6139.9079013813935;6143.84640383994;6148.139260503623;6163.876722465615;6088.695565221809;6098.969505152446;6136.7852125175405;6139.6009259398;6160.014397696526;5837.854053648693;5900.881982360414;5905.877883202178;5992.280926288873;5997.91003134962;6127.264728232462;6159.5072394209255;6166.136740856374;6170.753169873155;6181.011038233861;6005.699715014319;6048.848778780566;6054.485368743706;6104.20645316106;6142.986407242934 06:05:09 INFO - PROCESS | 1657 | |1;ext.html;458.4200985753021;467.201086142696;467.36438443716537;519.1900635009385;523.4503771040406;29284;30608.38783224334;33003.504947425776;33019.504707429405;33100;34184.97445076646;43707.562924370744;44178;44632.77683611577;46292;8542.530160841152;9716.076972687584;9735.464549449778;9867.506624668773;9888.060634239735;9781.853272200922;9893.109620134186;9893.25800564957;9901.75245618858;9905.554250058765;8776.034636190014;8982.281417486618;12077;12299.631011069638;12344.876551234462;12312.938435307811;12349.93825030878;12357.876421235762;12362.38188090592;12386.504539818487;10322.948385258025;12111.757764844653;12171.33057681827;12200.267983920992;12211.877881221251;31793.364132717215;32200.516992245135;40976.56582019615;41115.177696445906;41266;3399.7280217582534;3426.8629254829775;3450.8102054387;3480.2343484433386;3724.9813750931344;28859.27851803701;29869.850650746823;30678.69321306803;30687.693123068708;31249.687503125133;3138.8587513561943;3235.6279027911855;3242.3353212591596;3261.5596894419186;3314.2708604107297;539804.6019539793;541304;543489;543601.999999996;544279.2786036084;53700.19449708257;54855.33729632946;61799;63221.367786322466;63890.68054659697;63951.720965580425;67178.66410668014;67234;67243.66378168078;67256.66371668209;16531.504054878373;16686.666266674598;16710.498685039467;16713.749293760604;16742.24659890308;12863.549775757803;12942.029347798953;12942.935285323512;12947.028972827076;12964.092513524152;15555;17649.470515884543;17887.642247154985;17923.910380448277;17953.281868725106;5410.756515956791;6602.2407423146;6630.270670226271;6630.336966303331;6666.600003999775;850.4004676702909;900.4417261298037;995.6515219673056;1035.8135535603665;1071.2019545438698;29267.414651707273;30347.544786828214;30354.84822575917;30690.389188272988;30726.539101913488;919.9080091990882;1058.30680904008;1063.803196408667;1082.691432941608;1163.2148299897535;12210.572629958087;15094;15667.2949717263;15689.607759806097;16076.839231607768;579146;605008;690425;697850;702193;59800;59889.700551496964;59907;59960.800783984945;59964.70017649884;1364.8703373179533;1377.8415482219673;1405.943762249519;1406.9296535173405;1409.0981771666143;29134;29217.97737079277;29755.55366669545;29788.851055744584;30391.84804076054;49393.76515587139;51460;51816.222756657924;51873.96252075013;51958.96082078413;587304;588194.118058814;592181;594324;597578;34262.65737342694;41248.762537123934;41572.37641435441;41576.79211603923;42632;47298.76350618225;48190.27714584354;48385.27422088601;48857.267140992204;49621.25568116553;39149.6085039146;40236.1952760949;40415.1916961665;41033.589664102976;41527.792361038;33699.32601348008;35145.64854351424;38195.809020954715;39776.60223397845;40858;38352.42471362876;38875.222495549366;39032.804835975636;39120.21759564849;40339.79830100948;26728.732712672623;34304;36031.63968360388;36168.638313616524;36637.45043824398;25301.240962771146;26278.343041424116;26377.68111594451;26441.206763797116;26614.467710646066 06:05:09 INFO - PROCESS | 1657 | |2;jquery.html;373.0710530778359;376.8454933477275;385.3237568068041;391.32301119064;404.43783141433414;19236.13437395317;21681.80750058746;21797.237096701618;22000.88999555002;22049.559008819815;20380.490487737814;20530.281440149596;21080.578388432223;21375.144994200215;21385.2515161969;5822.359540450547;5871.3541510433815;6104.175936248594;6178.227721534809;6219;3907.4529565860803;4048.4736984192014;6178.7219575119225;6232.719527621268;6238.781642642509;3732.4961130247475;6110.388961103877;6233.096201050845;6250.062490626419;6251.12484252205;5965.671888046156;6142.96928515359;6202.658853763041;6229.37706229378;6250.249970003606;6020.488258498033;6028.186194863725;6031.668258245794;6032.004719221323;6040.5469589780505;13184.077114601982;13257.867421325856;13503.864961350457;13624;13775.448982040807;2151.7955794199524;2201.7230006596137;2242.9887850560644;2252;2797.6642802863585;8713.869291960626;9826.508674566314;9988.800223995479;10031;10574.10120139789;1841.327915310902;1880.990595047016;1921.193098898466;1979.3072424651257;1980.0396807548327;105380;126576;131911.34044329813;135418.999999999;136793.3160334192;9777.46223957675;10316.019978102067;11551.884481155248;11655.358955257543;11827.586034488751;14881.10713357202;14883.851161488463;14890.702185956221;14904.925475372555;14906.552803415914;7036.19083805369;8667.826643467095;8679.783005424915;8719.782005449788;8789.252913502296;8603.741887743377;8627.482351058956;8772.210501054935;8796.252318552866;8844.115588441104;4435.2016637005;4565.977170114128;4568.771561421916;4577.198990176706;4645.767711614406;1615.3700056977552;1732.4023211991844;1836.8714190006572;1895.365052707331;1900.7148927660962;600.1837500998638;714.2678754276908;844.0462277626366;928.9163975242261;951.6669165791917;17168.141592920303;21822.563459106295;21858.01638926252;21872.45318867041;21947.561048778934;867.8823670244583;943.9575219115156;994.4530508220449;1036.549101141006;1054.362110922896;11032.834507482394;11253.887461125447;11311.34183466901;11668;11689.064874809996;619771.9011405004;632659;639887;642378;655075;139449;141791;142187;146450;153369;988.9357191782511;992.161623428202;1008.1934452438167;1011.489197955028;1012.3015119567475;15945.68108637844;18551.35070272534;19174.424767257005;19257.4222773317;19405.8059419404;54003;55636.88726225534;56534.43465565292;56715.86568268529;57014.42985570091;67687;81972.77040844272;84624.57687711522;85335.29329413502;89298;5544.972275138599;8120.390970677341;8175.67297308101;8296.83406331882;8443.831123377375;11201;13139.802902956271;13354.265515396746;13555.932220338835;13640.454381824617;11349.432528373713;11599.130065244972;11671.941640291745;11926.701832454259;11995.980341670707;11472.770544589228;11474.139439542234;11817.763644726885;11829.940850295694;12069;11403.201775875608;11743.354115523387;11798.587049453572;11806.763864722485;12194.024478041558;8083.474574152897;8169.305609023299;8431.704890328809;8501.234888860032;8543.359248056297;9690;10244.795104098026;11189.04893084097;11602.70993225176;11811.468483918416 06:05:09 INFO - PROCESS | 1657 | |3;mootools.html;1502.2638906935601;1521.6348076461647;1681.7981842178933;1801.2344753479767;1839.5493104189475;8461.196186362293;9024.684136055248;9034.90965090349;9059.864102038475;9096.68161614342;7856.17510161432;8083.353331733462;8085.716999905005;8194.016717993849;8790.51652159131;2170.0994087453687;2208.8012078912893;2326.0695721711368;2403.8197135214928;2407.9759202408013;2405.518896220754;2407.3981504623844;2409.3976505873534;2410.1323523531514;2410.602250628644;2362.0669835415;2400.3759022654062;2411.336882357357;2413.5655581995234;2479.2686157583557;2363.8108951283943;2376.7623237676266;2389.892454839536;2394.4253379188867;2394.760523947609;2366.3847399676038;2372.2290255666803;2374.81001519878;2391.8086553075887;2398.8080953523677;8871.334649901282;8943;8952.776180595472;8977.820443591092;8996.100389961017;5267.525922666979;5434.239206511092;5440.238366628675;5446.128619420873;5451.3458384993655;3582.659647333499;3662.908427289339;3758.285925674113;3761.567419746737;3765.6046115157787;912.3567884641312;1113.3264375053138;1118.2619471149085;1751.1681951073265;1806.3948577226645;11587.362695051768;11638.243514171552;11691.590794322157;11701.53193872244;11716.53133874644;3365.9663403366144;4467.687261891637;4697.365855609517;4700.271457924027;4711.3639658646325;9136.040715724886;9142.177204051533;9152;9157.954210228907;9158.129977652112;5200.765965531485;5272.103742363807;5299.682019078868;5310.256564081032;5323.547498462596;4815.133276010351;4893.241547560134;4953.7523123844385;4968.056069346812;4971.925421118686;3547.5742910850345;3679.8896033118513;3769.7172712046704;3888.358420860583;3889.2999260132883;992.2111921022804;1011.1556850030307;1173.8884805943592;1176.0591526778715;1185.6917201527665;787.5353541410595;863.7624653220289;899.5637115998735;902.6885724425063;916.8945571259391;5666.518345940559;5673.886522269614;5728.914066289009;5925;6150.354212807681;946.3564775952418;953.208836665566;956.9473678947586;977.237754551451;996.0139461932635;3892.4745159403683;3921.7254792164845;3948.269570129478;4055.6349928506575;4072.124493233969;10455.84316235257;10887.510062047228;10896.346219226873;10900;10917.017468427879;10444.791104178026;10839;10846;10855.945720271347;10874.184436167161;7963.243491868379;8267;8277.089520152778;8287.917120828835;8305.792355191048;5131.819681473207;5624.971875140598;5767.769289228384;5799.536037116936;5943.791967281124;9949.552270147717;10082.949585252027;10222.0289072538;10251.436171010666;10269.127124194229;9741.853872192065;10204.2346823987;10540.525676344736;10541.525631346454;10572.84140737905;7163.677634506564;7248.420126389981;7254.927450725636;7263.346298832919;7263.4915555910575;7622.809429764078;7857.685692572233;7874;7947.841043178988;7974.122846486765;6938.722451101899;7257.455690823103;7516.135644400745;7526.134494533198;7573.129090154483;7337.1929087799235;7348.485606007528;7372.078490188726;7437.665305061393;7487.513311634726;6792.694328755119;6849.1438570178725;6919.481038922;6924;6929.549579277331;4895.363602731764;4903.239997800347;5007.349044624176;5024.6231532634465;5174.6119041072825;4943.728094954812;4966.230234313687;4971.453140154653;5024.899502010013;5067.391912970467 06:05:09 INFO - PROCESS | 1657 | |4;prototype.html;300.21493793729405;303.2176983382872;310.2151556561898;314.2771625261897;316.13379340606747;5072.619553533481;5224.268602395668;5248.6063545234065;5272.604554658402;5297.44376840432;4998.800047998076;5140.794368225266;5172.405178401013;5196.402413722423;5211.5049070338355;4026.5772093930154;4032.354823228284;4045.8786236412957;4060.451839001734;4060.776657283848;3869.496965394509;3972.304846651839;4070.2266569351727;4079.8368065277355;4125.7524548527035;3801.3537698591167;3890.591487893773;3896.8246428910766;4000.3399439092514;4018.7789671568053;3294.8846790362463;3314.4199765041144;3946.960530394717;3957.3668213085766;3982.940255896149;3300.042987533612;3353.6814002669707;3475.402957938547;3490.284491679225;3506.789592624425;4144.254034273829;4459.996500787297;4612.607928326096;4657.86026419208;5101.770420331094;4560.749158796265;4574.4510658721165;4577.748223847687;4584.977075114636;4617.976910115428;4842.02215637384;5017.874553136165;5111.08000559899;5504.146857237135;5530.834074977717;3697.500837386945;3754.8597299539274;3759.0602349412648;3845.4616353710503;3887.3974533947285;4966.498618473967;5126.871828204325;5723.198752174699;5762.798302059407;5832.912506312408;3321.933561328808;3875.779129574175;3877.3602355611574;3894.824732887027;3912.256671232514;3244.9291733727814;3321.568196134487;3830.2339532093692;3900.3564411871725;3987.401889716508;3793.918733161091;3795.35478968576;4194.951262184454;4358.101862261624;4595.770211489412;4830.806767729322;5494.2857428534035;5519.530839878575;5520.66875987434;5522.502974732213;1274.3118715893313;1329.5745361484426;1361.7072329449018;1366.685662297677;1366.8906487480979;770.8805135203941;785.9331956783737;839.9790005249918;840.8774286327821;861.9225967540574;4345.609914546986;4346.80486354389;4357.69269219233;4379.0585024219945;4383.7642802170485;4712.010477799632;4739.786709598076;4758.381410416624;4822.614190864722;4838.540338667821;4198.685098617616;4305.547917468683;4619.5611416915335;5030.37120359955;5179.326687530597;2755.2147637923094;2956.911292661224;2980.687027862087;2993.0721476342405;3000.4149190907565;4948.727819969936;5424.593155513352;5717.599768016199;5888.440598143169;5904.557158213065;5776.469235652556;5827.3298570664065;5830.47525722687;5861.3552509223955;5886.940350736822;5154.92267615986;5346.19807028941;5881.9705901470215;5918.644881307136;5931.406859314034;4521.706089104197;4988.9251661225835;5322.707251101227;5682.744276507649;5703.691858722014;4738.360321356573;4757.3577567028005;4781.115493633689;5557.805476808292;5613.550915926798;4690.92963605553;5211.254229833048;5614.9719251403485;5891.3224979127945;5906.527477801851;3611.9458208127426;3843.7501562398356;3879.9224015520094;3899.668528175137;3901.45379646844;5253.894922101613;5733.512651424676;5765.538756899522;5773.595848290579;5839.240898683144;5627.240322556566;5648.943510564842;5671.412004638708;5671.574631902541;5699.658020518782;4782.282657601388;4820.939393333461;5286.62993590445;5565.3599836019375;5576.944230557642;4248.596383343577;5463.890722185454;5477.726113694379;5501.917471237854;5547.4175211603815;5265.868353291198;5519.97042159218;5610.85972850682;5626.043572592751;5637.646964728354;4494.483134439451;5457;5486.61593688438;5501.2121060654645;5590.916136257878 06:05:09 INFO - PROCESS | 1657 | |5;yui.html;617.6078190349128;703.3810246982657;779.9142094369622;797.9321757650599;811.3792948394479;14800.333984970675;15442;15997.760033599476;16020.519384418472;16522;11763.176577639568;12231.877681223184;12403.813942790865;12405.007599392049;12433.875661243408;678.5792808458763;696.0811728518357;846.369454756206;872.8036191856813;874.3748220022683;841.3017195727562;859.3168431097292;869.7260362985639;880.6037283222576;882.3779235638859;918.2608000559546;919.4207649181006;920.9593159729529;923.9260859131253;924.6717415317567;716.5414134953634;747.5664114813395;916.2990312410977;920.3327587499043;921.4885738415177;559.980400685974;561.5816216918381;561.8763871948165;654.6693919570635;681.7750142452978;15160.620984475367;15172.468963586221;15285.694286114327;15296.847031529765;15321.157336346496;13958;14197.787033194407;14287.357068931922;14372.568822935329;14589.270536473134;12283.631491055283;12325;12438.440270187863;13105.082644214908;13400.932995335059;4499.797509112098;4585.082983403333;4664.55686709762;4669.439667239919;4759.381280433521;101873.9812601872;104688.47655761748;116532;118762;123502;10400.375977441226;10972.01251887334;11019.779604407868;11210.775784484427;11274.605388811517;21997.340079797632;22036.779632203474;22041.448963776034;22042.44893877634;22043.228487002878;7664.156942736295;7767.067951845815;7772.7668169954995;7909.5649739263745;8037.678492860337;4366.541513141138;4379.868603941887;4461.531539188403;4514.435695538058;4583.977080114578;3197.552342672028;3448.2930999145615;3509.385682586039;3594.694450971697;3598.604153543108;631.0938129911782;648.8280605639509;658.8319978405476;667.679513833353;668.7893313606198;599;614.3948211012149;615.879903418838;619;620.8975519039308;8954.641814327353;9207.63169473227;9208.401453905475;9283.90716092844;9319.440833550008;584.6755050946765;595.976160953557;612.1980205930246;616.2912650452016;637.5562330556018;4327.653787696977;4491.887702807456;4504.234280172379;4514.210013247669;4517.954820451753;162163.56754648688;167483.1625841863;171337;175773;179790.1010494939;113357.73284534428;116087;116722.24916626257;120764;121531;75820;77859.22140778633;101174.99999999853;101732.49133754284;119798.80201197877;9343.252539796664;9899.802003959736;9972.451515166735;9992.550335235077;10045.849312260176;56381.71809140928;61086.38913610807;61998.070028950504;62734.68632656807;62789;80629;83759;96014.51992739992;99623;100685.4965725196;13397.53108641193;13812.378442970292;13821.723565528835;13889.791653125008;14363.497277595234;14055.508057217949;14990.775138373152;15181;15257.08457492554;15316.310766015333;13796;13923.164610123426;13954.58136255914;14237.288135592971;14238.786418203528;12960.675983100498;13449.86550134486;14641.780373294196;14666.413343466142;15100.39598416051;11544.422778860855;12949.223046617233;13477.595672129852;14501.492447764278;14538.781918271023;11404.885951140383;11518;11671.708207294885;11996.64010079699;12296;11586.420678966186;11771.646850594496;11852.466639001437;11866.466009029788;11901.702457438634 06:05:09 INFO - PROCESS | 1657 | __end_tp_report 06:05:09 INFO - PROCESS | 1657 | __start_cc_report 06:05:09 INFO - PROCESS | 1657 | _x_x_mozilla_cycle_collect,1786 06:05:09 INFO - PROCESS | 1657 | __end_cc_report 06:05:09 INFO - PROCESS | 1657 | __startTimestamp1476363909576__endTimestamp 06:05:09 INFO - PROCESS | 1657 | 06:05:09 INFO - PROCESS | 1657 | ------- Summary: start ------- 06:05:09 INFO - PROCESS | 1657 | Number of tests: 6 06:05:09 INFO - PROCESS | 1657 | 06:05:09 INFO - PROCESS | 1657 | [#0] dojo.html Cycles:165 Average:5808.75 Median:6032.94 stddev:645.78 (10.7%) stddev-sans-first:617.96 06:05:09 INFO - PROCESS | 1657 | Values: 3337.1 3337.2 3369.6 3374.5 3410.8 5774.9 5788.5 5803.9 5811.2 5827.0 5756.0 5779.8 5858.8 5862.1 5876.1 5167.7 5217.0 5275.5 5296.1 5307.7 5199.3 5221.1 5225.9 5327.1 5331.8 5238.2 5317.0 5334.0 5338.4 5341.7 5262.7 5276.6 5294.4 5335.3 5340.7 5234.7 5265.1 5292.2 5297.9 5299.9 5529.8 5561.8 5570.3 5658.2 5784.3 6252.0 6336.0 6350.0 6354.5 6378.7 6320.9 6362.6 6376.8 6377.6 6394.0 5721.1 5768.3 5776.9 5861.6 5875.3 6249.1 6289.4 6332.7 6345.4 6345.5 6222.6 6229.2 6236.8 6249.2 6257.1 6201.0 6206.8 6386.8 6393.6 6414.9 6133.8 6136.3 6169.0 6169.8 6260.2 6278.9 6288.8 6300.2 6305.7 6316.1 4900.4 4943.6 4948.7 4952.9 4982.4 4407.3 4435.4 4454.8 4509.7 4512.2 5835.2 5870.6 5872.5 5891.9 5895.6 5405.0 6266.8 6305.7 6330.0 6340.7 5918.8 5919.5 5934.8 5957.2 5976.5 5505.7 5519.8 5530.5 5530.7 5536.7 6233.3 6264.1 6317.0 6362.9 6388.6 6337.1 6340.5 6349.4 6378.6 6401.9 6359.5 6365.2 6367.4 6370.7 6384.7 6138.1 6143.7 6307.4 6310.7 6316.4 6032.9 6185.8 6276.2 6294.5 6338.2 6136.0 6139.9 6143.8 6148.1 6163.9 6088.7 6099.0 6136.8 6139.6 6160.0 5837.9 5900.9 5905.9 5992.3 5997.9 6127.3 6159.5 6166.1 6170.8 6181.0 6005.7 6048.8 6054.5 6104.2 6143.0 06:05:09 INFO - PROCESS | 1657 | 06:05:09 INFO - PROCESS | 1657 | [#1] ext.html Cycles:180 Average:73005.61 Median:38274.12 stddev:160107.85 (418.3%) stddev-sans-first:160464.34 06:05:09 INFO - PROCESS | 1657 | Values: 458.4 467.2 467.4 519.2 523.5 29284.0 30608.4 33003.5 33019.5 33100.0 34185.0 43707.6 44178.0 44632.8 46292.0 8542.5 9716.1 9735.5 9867.5 9888.1 9781.9 9893.1 9893.3 9901.8 9905.6 8776.0 8982.3 12077.0 12299.6 12344.9 12312.9 12349.9 12357.9 12362.4 12386.5 10322.9 12111.8 12171.3 12200.3 12211.9 31793.4 32200.5 40976.6 41115.2 41266.0 3399.7 3426.9 3450.8 3480.2 3725.0 28859.3 29869.9 30678.7 30687.7 31249.7 3138.9 3235.6 3242.3 3261.6 3314.3 539804.6 541304.0 543489.0 543602.0 544279.3 53700.2 54855.3 61799.0 63221.4 63890.7 63951.7 67178.7 67234.0 67243.7 67256.7 16531.5 16686.7 16710.5 16713.7 16742.2 12863.5 12942.0 12942.9 12947.0 12964.1 15555.0 17649.5 17887.6 17923.9 17953.3 5410.8 6602.2 6630.3 6630.3 6666.6 850.4 900.4 995.7 1035.8 1071.2 29267.4 30347.5 30354.8 30690.4 30726.5 919.9 1058.3 1063.8 1082.7 1163.2 12210.6 15094.0 15667.3 15689.6 16076.8 579146.0 605008.0 690425.0 697850.0 702193.0 59800.0 59889.7 59907.0 59960.8 59964.7 1364.9 1377.8 1405.9 1406.9 1409.1 29134.0 29218.0 29755.6 29788.9 30391.8 49393.8 51460.0 51816.2 51874.0 51959.0 587304.0 588194.1 592181.0 594324.0 597578.0 34262.7 41248.8 41572.4 41576.8 42632.0 47298.8 48190.3 48385.3 48857.3 49621.3 39149.6 40236.2 40415.2 41033.6 41527.8 33699.3 35145.6 38195.8 39776.6 40858.0 38352.4 38875.2 39032.8 39120.2 40339.8 26728.7 34304.0 36031.6 36168.6 36637.5 25301.2 26278.3 26377.7 26441.2 26614.5 06:05:09 INFO - PROCESS | 1657 | 06:05:09 INFO - PROCESS | 1657 | [#2] jquery.html Cycles:180 Average:36811.80 Median:12125.64 stddev:106899.08 (881.6%) stddev-sans-first:107163.95 06:05:09 INFO - PROCESS | 1657 | Values: 373.1 376.8 385.3 391.3 404.4 19236.1 21681.8 21797.2 22000.9 22049.6 20380.5 20530.3 21080.6 21375.1 21385.3 5822.4 5871.4 6104.2 6178.2 6219.0 3907.5 4048.5 6178.7 6232.7 6238.8 3732.5 6110.4 6233.1 6250.1 6251.1 5965.7 6143.0 6202.7 6229.4 6250.2 6020.5 6028.2 6031.7 6032.0 6040.5 13184.1 13257.9 13503.9 13624.0 13775.4 2151.8 2201.7 2243.0 2252.0 2797.7 8713.9 9826.5 9988.8 10031.0 10574.1 1841.3 1881.0 1921.2 1979.3 1980.0 105380.0 126576.0 131911.3 135419.0 136793.3 9777.5 10316.0 11551.9 11655.4 11827.6 14881.1 14883.9 14890.7 14904.9 14906.6 7036.2 8667.8 8679.8 8719.8 8789.3 8603.7 8627.5 8772.2 8796.3 8844.1 4435.2 4566.0 4568.8 4577.2 4645.8 1615.4 1732.4 1836.9 1895.4 1900.7 600.2 714.3 844.0 928.9 951.7 17168.1 21822.6 21858.0 21872.5 21947.6 867.9 944.0 994.5 1036.5 1054.4 11032.8 11253.9 11311.3 11668.0 11689.1 619771.9 632659.0 639887.0 642378.0 655075.0 139449.0 141791.0 142187.0 146450.0 153369.0 988.9 992.2 1008.2 1011.5 1012.3 15945.7 18551.4 19174.4 19257.4 19405.8 54003.0 55636.9 56534.4 56715.9 57014.4 67687.0 81972.8 84624.6 85335.3 89298.0 5545.0 8120.4 8175.7 8296.8 8443.8 11201.0 13139.8 13354.3 13555.9 13640.5 11349.4 11599.1 11671.9 11926.7 11996.0 11472.8 11474.1 11817.8 11829.9 12069.0 11403.2 11743.4 11798.6 11806.8 12194.0 8083.5 8169.3 8431.7 8501.2 8543.4 9690.0 10244.8 11189.0 11602.7 11811.5 06:05:09 INFO - PROCESS | 1657 | 06:05:09 INFO - PROCESS | 1657 | [#3] mootools.html Cycles:180 Average:5685.55 Median:4989.64 stddev:3174.66 (63.6%) stddev-sans-first:3168.00 06:05:09 INFO - PROCESS | 1657 | Values: 1502.3 1521.6 1681.8 1801.2 1839.5 8461.2 9024.7 9034.9 9059.9 9096.7 7856.2 8083.4 8085.7 8194.0 8790.5 2170.1 2208.8 2326.1 2403.8 2408.0 2405.5 2407.4 2409.4 2410.1 2410.6 2362.1 2400.4 2411.3 2413.6 2479.3 2363.8 2376.8 2389.9 2394.4 2394.8 2366.4 2372.2 2374.8 2391.8 2398.8 8871.3 8943.0 8952.8 8977.8 8996.1 5267.5 5434.2 5440.2 5446.1 5451.3 3582.7 3662.9 3758.3 3761.6 3765.6 912.4 1113.3 1118.3 1751.2 1806.4 11587.4 11638.2 11691.6 11701.5 11716.5 3366.0 4467.7 4697.4 4700.3 4711.4 9136.0 9142.2 9152.0 9158.0 9158.1 5200.8 5272.1 5299.7 5310.3 5323.5 4815.1 4893.2 4953.8 4968.1 4971.9 3547.6 3679.9 3769.7 3888.4 3889.3 992.2 1011.2 1173.9 1176.1 1185.7 787.5 863.8 899.6 902.7 916.9 5666.5 5673.9 5728.9 5925.0 6150.4 946.4 953.2 956.9 977.2 996.0 3892.5 3921.7 3948.3 4055.6 4072.1 10455.8 10887.5 10896.3 10900.0 10917.0 10444.8 10839.0 10846.0 10855.9 10874.2 7963.2 8267.0 8277.1 8287.9 8305.8 5131.8 5625.0 5767.8 5799.5 5943.8 9949.6 10082.9 10222.0 10251.4 10269.1 9741.9 10204.2 10540.5 10541.5 10572.8 7163.7 7248.4 7254.9 7263.3 7263.5 7622.8 7857.7 7874.0 7947.8 7974.1 6938.7 7257.5 7516.1 7526.1 7573.1 7337.2 7348.5 7372.1 7437.7 7487.5 6792.7 6849.1 6919.5 6924.0 6929.5 4895.4 4903.2 5007.3 5024.6 5174.6 4943.7 4966.2 4971.5 5024.9 5067.4 06:05:09 INFO - PROCESS | 1657 | 06:05:09 INFO - PROCESS | 1657 | [#4] prototype.html Cycles:180 Average:4405.95 Median:4769.75 stddev:1351.13 (28.3%) stddev-sans-first:1319.31 06:05:09 INFO - PROCESS | 1657 | Values: 300.2 303.2 310.2 314.3 316.1 5072.6 5224.3 5248.6 5272.6 5297.4 4998.8 5140.8 5172.4 5196.4 5211.5 4026.6 4032.4 4045.9 4060.5 4060.8 3869.5 3972.3 4070.2 4079.8 4125.8 3801.4 3890.6 3896.8 4000.3 4018.8 3294.9 3314.4 3947.0 3957.4 3982.9 3300.0 3353.7 3475.4 3490.3 3506.8 4144.3 4460.0 4612.6 4657.9 5101.8 4560.7 4574.5 4577.7 4585.0 4618.0 4842.0 5017.9 5111.1 5504.1 5530.8 3697.5 3754.9 3759.1 3845.5 3887.4 4966.5 5126.9 5723.2 5762.8 5832.9 3321.9 3875.8 3877.4 3894.8 3912.3 3244.9 3321.6 3830.2 3900.4 3987.4 3793.9 3795.4 4195.0 4358.1 4595.8 4830.8 5494.3 5519.5 5520.7 5522.5 1274.3 1329.6 1361.7 1366.7 1366.9 770.9 785.9 840.0 840.9 861.9 4345.6 4346.8 4357.7 4379.1 4383.8 4712.0 4739.8 4758.4 4822.6 4838.5 4198.7 4305.5 4619.6 5030.4 5179.3 2755.2 2956.9 2980.7 2993.1 3000.4 4948.7 5424.6 5717.6 5888.4 5904.6 5776.5 5827.3 5830.5 5861.4 5886.9 5154.9 5346.2 5882.0 5918.6 5931.4 4521.7 4988.9 5322.7 5682.7 5703.7 4738.4 4757.4 4781.1 5557.8 5613.6 4690.9 5211.3 5615.0 5891.3 5906.5 3611.9 3843.8 3879.9 3899.7 3901.5 5253.9 5733.5 5765.5 5773.6 5839.2 5627.2 5648.9 5671.4 5671.6 5699.7 4782.3 4820.9 5286.6 5565.4 5576.9 4248.6 5463.9 5477.7 5501.9 5547.4 5265.9 5520.0 5610.9 5626.0 5637.6 4494.5 5457.0 5486.6 5501.2 5590.9 06:05:09 INFO - PROCESS | 1657 | 06:05:09 INFO - PROCESS | 1657 | [#5] yui.html Cycles:180 Average:24952.56 Median:3322.92 stddev:40430.37 (1216.7%) stddev-sans-first:40502.50 06:05:09 INFO - PROCESS | 1657 | Values: 617.6 703.4 779.9 797.9 811.4 14800.3 15442.0 15997.8 16020.5 16522.0 11763.2 12231.9 12403.8 12405.0 12433.9 678.6 696.1 846.4 872.8 874.4 841.3 859.3 869.7 880.6 882.4 918.3 919.4 921.0 923.9 924.7 716.5 747.6 916.3 920.3 921.5 560.0 561.6 561.9 654.7 681.8 15160.6 15172.5 15285.7 15296.8 15321.2 13958.0 14197.8 14287.4 14372.6 14589.3 12283.6 12325.0 12438.4 13105.1 13400.9 4499.8 4585.1 4664.6 4669.4 4759.4 101874.0 104688.5 116532.0 118762.0 123502.0 10400.4 10972.0 11019.8 11210.8 11274.6 21997.3 22036.8 22041.4 22042.4 22043.2 7664.2 7767.1 7772.8 7909.6 8037.7 4366.5 4379.9 4461.5 4514.4 4584.0 3197.6 3448.3 3509.4 3594.7 3598.6 631.1 648.8 658.8 667.7 668.8 599.0 614.4 615.9 619.0 620.9 8954.6 9207.6 9208.4 9283.9 9319.4 584.7 596.0 612.2 616.3 637.6 4327.7 4491.9 4504.2 4514.2 4518.0 162163.6 167483.2 171337.0 175773.0 179790.1 113357.7 116087.0 116722.2 120764.0 121531.0 75820.0 77859.2 101175.0 101732.5 119798.8 9343.3 9899.8 9972.5 9992.6 10045.8 56381.7 61086.4 61998.1 62734.7 62789.0 80629.0 83759.0 96014.5 99623.0 100685.5 13397.5 13812.4 13821.7 13889.8 14363.5 14055.5 14990.8 15181.0 15257.1 15316.3 13796.0 13923.2 13954.6 14237.3 14238.8 12960.7 13449.9 14641.8 14666.4 15100.4 11544.4 12949.2 13477.6 14501.5 14538.8 11404.9 11518.0 11671.7 11996.6 12296.0 11586.4 11771.6 11852.5 11866.5 11901.7 06:05:09 INFO - PROCESS | 1657 | -------- Summary: end -------- 06:05:09 INFO - PROCESS | 1657 | 06:05:10 INFO - TEST-INFO | 1657: exit 0 06:05:10 INFO - TEST-OK | dromaeo_css | took 1116453ms 06:05:10 INFO - TEST-START | kraken 06:05:10 INFO - operating with platform_type : mac_ 06:05:10 INFO - Initialising browser for kraken test... 06:05:10 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/tmpYUmN5M/profile http://localhost:49267/getInfo.html) 06:05:12 INFO - PROCESS | 1664 | __metrics Screen width/height:1600/1200 06:05:12 INFO - PROCESS | 1664 | colorDepth:24 06:05:12 INFO - PROCESS | 1664 | Browser inner width/height: 1024/689 06:05:12 INFO - PROCESS | 1664 | __metrics 06:05:12 INFO - PROCESS | 1664 | 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" 06:05:12 INFO - PROCESS | 1664 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:05:13 INFO - TEST-INFO | 1664: exit 0 06:05:13 INFO - Browser initialized. 06:05:13 INFO - Running cycle 1/1 for kraken test... 06:05:13 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/tmpYUmN5M/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:05:25 INFO - PROCESS | 1665 | RSS: Main: 219099136 06:05:25 INFO - PROCESS | 1665 | 06:05:28 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection) 06:05:28 INFO - PROCESS | 1665 | RSS: Main: 269090816 06:05:28 INFO - PROCESS | 1665 | 06:05:31 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-dft) 06:05:32 INFO - PROCESS | 1665 | RSS: Main: 279846912 06:05:32 INFO - PROCESS | 1665 | 06:05:35 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-fft) 06:05:35 INFO - PROCESS | 1665 | RSS: Main: 376164352 06:05:35 INFO - PROCESS | 1665 | 06:05:37 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator) 06:05:38 INFO - PROCESS | 1665 | RSS: Main: 278929408 06:05:38 INFO - PROCESS | 1665 | 06:05:40 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:05:41 INFO - PROCESS | 1665 | RSS: Main: 279760896 06:05:41 INFO - PROCESS | 1665 | 06:05:43 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom) 06:05:44 INFO - PROCESS | 1665 | RSS: Main: 318423040 06:05:44 INFO - PROCESS | 1665 | 06:05:47 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate) 06:05:48 INFO - PROCESS | 1665 | RSS: Main: 320053248 06:05:48 INFO - PROCESS | 1665 | 06:05:51 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial) 06:05:51 INFO - PROCESS | 1665 | RSS: Main: 315170816 06:05:51 INFO - PROCESS | 1665 | 06:05:53 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:05:54 INFO - PROCESS | 1665 | RSS: Main: 289722368 06:05:54 INFO - PROCESS | 1665 | 06:05:56 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:05:56 INFO - PROCESS | 1665 | RSS: Main: 294424576 06:05:56 INFO - PROCESS | 1665 | 06:05:58 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:05:59 INFO - PROCESS | 1665 | RSS: Main: 299565056 06:05:59 INFO - PROCESS | 1665 | 06:06:02 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:06:03 INFO - PROCESS | 1665 | RSS: Main: 309858304 06:06:03 INFO - PROCESS | 1665 | 06:06:06 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:06:06 INFO - PROCESS | 1665 | RSS: Main: 309661696 06:06:06 INFO - PROCESS | 1665 | 06:06:08 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49267/tests/kraken/driver.html?testName=ai-astar) 06:06:08 INFO - PROCESS | 1665 | RSS: Main: 353492992 06:06:08 INFO - PROCESS | 1665 | 06:06:08 INFO - PROCESS | 1665 | __start_tp_report 06:06:08 INFO - PROCESS | 1665 | _x_x_mozilla_page_load 06:06:08 INFO - PROCESS | 1665 | _x_x_mozilla_page_load_details 06:06:08 INFO - PROCESS | 1665 | |i|pagename|runs| 06:06:08 INFO - PROCESS | 1665 | |0;ai-astar;114;113;114;121;166;152;114;114;112;115 06:06:08 INFO - PROCESS | 1665 | |1;audio-beat-detection;143;107;112;174;140;111;109;108;156;134 06:06:08 INFO - PROCESS | 1665 | |2;audio-dft;186;184;185;187;184;186;184;183;185;185 06:06:08 INFO - PROCESS | 1665 | |3;audio-fft;80;59;57;89;65;58;58;58;81;56 06:06:08 INFO - PROCESS | 1665 | |4;audio-oscillator;88;70;94;69;68;69;92;68;90;124 06:06:08 INFO - PROCESS | 1665 | |5;imaging-gaussian-blur;89;100;88;86;88;85;92;86;88;85 06:06:08 INFO - PROCESS | 1665 | |6;imaging-darkroom;118;168;163;96;100;98;100;169;98;148 06:06:08 INFO - PROCESS | 1665 | |7;imaging-desaturate;85;103;124;139;134;85;86;86;85;85 06:06:08 INFO - PROCESS | 1665 | |8;json-parse-financial;57;53;53;55;56;58;58;58;58;58 06:06:08 INFO - PROCESS | 1665 | |9;json-stringify-tinderbox;64;70;71;73;72;68;69;67;73;100 06:06:08 INFO - PROCESS | 1665 | |10;stanford-crypto-aes;82;84;85;82;82;83;82;84;86;84 06:06:08 INFO - PROCESS | 1665 | |11;stanford-crypto-ccm;139;140;138;137;139;142;142;137;170;138 06:06:08 INFO - PROCESS | 1665 | |12;stanford-crypto-pbkdf2;167;167;167;202;230;202;172;168;167;167 06:06:08 INFO - PROCESS | 1665 | |13;stanford-crypto-sha256-iterative;68;67;67;66;65;67;67;67;67;66 06:06:08 INFO - PROCESS | 1665 | __end_tp_report 06:06:08 INFO - PROCESS | 1665 | __start_cc_report 06:06:08 INFO - PROCESS | 1665 | _x_x_mozilla_cycle_collect,1981 06:06:08 INFO - PROCESS | 1665 | __end_cc_report 06:06:08 INFO - PROCESS | 1665 | __startTimestamp1476363968592__endTimestamp 06:06:08 INFO - PROCESS | 1665 | 06:06:08 INFO - PROCESS | 1665 | ------- Summary: start ------- 06:06:08 INFO - PROCESS | 1665 | Number of tests: 14 06:06:08 INFO - PROCESS | 1665 | 06:06:08 INFO - PROCESS | 1665 | [#0] ai-astar Cycles:10 Average:123.50 Median:114.50 stddev:19.15 (16.7%) stddev-sans-first:20.00 06:06:08 INFO - PROCESS | 1665 | Values: 114.0 113.0 114.0 121.0 166.0 152.0 114.0 114.0 112.0 115.0 06:06:08 INFO - PROCESS | 1665 | 06:06:08 INFO - PROCESS | 1665 | [#1] audio-beat-detection Cycles:10 Average:129.40 Median:137.00 stddev:23.65 (17.3%) stddev-sans-first:24.56 06:06:08 INFO - PROCESS | 1665 | Values: 143.0 107.0 112.0 174.0 140.0 111.0 109.0 108.0 156.0 134.0 06:06:08 INFO - PROCESS | 1665 | 06:06:08 INFO - PROCESS | 1665 | [#2] audio-dft Cycles:10 Average:184.90 Median:185.00 stddev:1.20 (0.6%) stddev-sans-first:1.20 06:06:08 INFO - PROCESS | 1665 | Values: 186.0 184.0 185.0 187.0 184.0 186.0 184.0 183.0 185.0 185.0 06:06:08 INFO - PROCESS | 1665 | 06:06:08 INFO - PROCESS | 1665 | [#3] audio-fft Cycles:10 Average:66.10 Median:62.00 stddev:12.35 (19.9%) stddev-sans-first:12.03 06:06:08 INFO - PROCESS | 1665 | Values: 80.0 59.0 57.0 89.0 65.0 58.0 58.0 58.0 81.0 56.0 06:06:08 INFO - PROCESS | 1665 | 06:06:08 INFO - PROCESS | 1665 | [#4] audio-oscillator Cycles:10 Average:83.20 Median:79.00 stddev:18.16 (23.0%) stddev-sans-first:19.18 06:06:08 INFO - PROCESS | 1665 | Values: 88.0 70.0 94.0 69.0 68.0 69.0 92.0 68.0 90.0 124.0 06:06:08 INFO - PROCESS | 1665 | 06:06:08 INFO - PROCESS | 1665 | [#5] imaging-gaussian-blur Cycles:10 Average:88.70 Median:88.00 stddev:4.50 (5.1%) stddev-sans-first:4.77 06:06:08 INFO - PROCESS | 1665 | Values: 89.0 100.0 88.0 86.0 88.0 85.0 92.0 86.0 88.0 85.0 06:06:08 INFO - PROCESS | 1665 | 06:06:08 INFO - PROCESS | 1665 | [#6] imaging-darkroom Cycles:10 Average:125.80 Median:168.50 stddev:32.23 (19.1%) stddev-sans-first:34.06 06:06:08 INFO - PROCESS | 1665 | Values: 118.0 168.0 163.0 96.0 100.0 98.0 100.0 169.0 98.0 148.0 06:06:08 INFO - PROCESS | 1665 | 06:06:08 INFO - PROCESS | 1665 | [#7] imaging-desaturate Cycles:10 Average:101.20 Median:85.00 stddev:22.46 (26.4%) stddev-sans-first:23.04 06:06:08 INFO - PROCESS | 1665 | Values: 85.0 103.0 124.0 139.0 134.0 85.0 86.0 86.0 85.0 85.0 06:06:08 INFO - PROCESS | 1665 | 06:06:08 INFO - PROCESS | 1665 | [#8] json-parse-financial Cycles:10 Average:56.40 Median:58.00 stddev:2.07 (3.6%) stddev-sans-first:2.18 06:06:08 INFO - PROCESS | 1665 | Values: 57.0 53.0 53.0 55.0 56.0 58.0 58.0 58.0 58.0 58.0 06:06:08 INFO - PROCESS | 1665 | 06:06:08 INFO - PROCESS | 1665 | [#9] json-stringify-tinderbox Cycles:10 Average:72.70 Median:70.50 stddev:10.00 (14.2%) stddev-sans-first:10.10 06:06:08 INFO - PROCESS | 1665 | Values: 64.0 70.0 71.0 73.0 72.0 68.0 69.0 67.0 73.0 100.0 06:06:08 INFO - PROCESS | 1665 | 06:06:08 INFO - PROCESS | 1665 | [#10] stanford-crypto-aes Cycles:10 Average:83.40 Median:84.00 stddev:1.43 (1.7%) stddev-sans-first:1.42 06:06:08 INFO - PROCESS | 1665 | Values: 82.0 84.0 85.0 82.0 82.0 83.0 82.0 84.0 86.0 84.0 06:06:08 INFO - PROCESS | 1665 | 06:06:08 INFO - PROCESS | 1665 | [#11] stanford-crypto-ccm Cycles:10 Average:142.20 Median:139.50 stddev:9.93 (7.1%) stddev-sans-first:10.47 06:06:08 INFO - PROCESS | 1665 | Values: 139.0 140.0 138.0 137.0 139.0 142.0 142.0 137.0 170.0 138.0 06:06:08 INFO - PROCESS | 1665 | 06:06:08 INFO - PROCESS | 1665 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.90 Median:170.00 stddev:22.39 (13.2%) stddev-sans-first:23.18 06:06:08 INFO - PROCESS | 1665 | Values: 167.0 167.0 167.0 202.0 230.0 202.0 172.0 168.0 167.0 167.0 06:06:08 INFO - PROCESS | 1665 | 06:06:08 INFO - PROCESS | 1665 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:67.00 stddev:0.82 (1.2%) stddev-sans-first:0.73 06:06:08 INFO - PROCESS | 1665 | Values: 68.0 67.0 67.0 66.0 65.0 67.0 67.0 67.0 67.0 66.0 06:06:08 INFO - PROCESS | 1665 | -------- Summary: end -------- 06:06:08 INFO - PROCESS | 1665 | 06:06:09 INFO - TEST-INFO | 1665: exit 0 06:06:09 INFO - TEST-OK | kraken | took 59222ms 06:06:09 INFO - SUITE-END | took 1175s 06:06:09 INFO - Completed test suite (00:19:36) 06:06:09 INFO - javascript benchmark 06:06:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3337.065621625944, 3337.249118948236, 3369.629340772516, 3374.4769560718096, 3410.829458527073, 5774.942250577493, 5788.507976821965, 5803.912941305878, 5811.157382179592, 5826.9708651456785, 5755.971220143904, 5779.826605201851, 5858.76564937402, 5862.091375836752, 5876.11858221267, 5167.741612919348, 5217.034848553011, 5275.525202731754, 5296.073187192226, 5307.73461326934, 5199.272101905736, 5221.086309895772, 5225.947740522603, 5327.094393953018, 5331.786728530854, 5238.240455134003, 5316.9734151329385, 5334.03987282289, 5338.439463856297, 5341.679499230039, 5262.657927234755, 5276.551493123089, 5294.364676238837, 5335.253064570963, 5340.67955922642, 5234.738263086831, 5265.078611243017, 5292.179712144623, 5297.920531192035, 5299.947000529984, 5529.806456773994, 5561.833145005616, 5570.3315602128005, 5658.207850900877, 5784.305883294031, 6252.0, 6336.049592561107, 6350.0, 6354.459870910978, 6378.712957916905, 6320.873582528369, 6362.586431881913, 6376.776812811529, 6377.553571250014, 6393.9680301598655, 5721.141828725725, 5768.307803063659, 5776.942230577724, 5861.618994765369, 5875.265591801025, 6249.0626406039455, 6289.433950944437, 6332.715027823759, 6345.428911397904, 6345.460635846005, 6222.595531290543, 6229.190205273286, 6236.812895613139, 6249.187605611241, 6257.092721555349, 6200.968995154995, 6206.751729930843, 6386.776462823779, 6393.648349340738, 6414.903776443357, 6133.785317513865, 6136.280772554046, 6168.9691551541955, 6169.8457538561, 6260.248770147611, 6278.874422511524, 6288.779892703734, 6300.243970723543, 6305.747770089237, 6316.147320111818, 4900.362952816183, 4943.604511639061, 4948.678335908155, 4952.90094198114, 4982.427020892571, 4407.338899165086, 4435.35687325336, 4454.844080457168, 4509.729416235036, 4512.187806194851, 5835.183074369592, 5870.55970802183, 5872.530197584183, 5891.911621325684, 5895.557833162444, 5404.972975135099, 6266.843328916813, 6305.716242769086, 6329.9872020476505, 6340.7463701451425, 5918.822435326947, 5919.526437884959, 5934.762609495659, 5957.195778569924, 5976.491998180203, 5505.697186654773, 5519.806806761744, 5530.5299049580435, 5530.723463826793, 5536.723163841792, 6233.34549872266, 6264.060390941395, 6316.968415157895, 6362.936370636235, 6388.5528013039575, 6337.144485494584, 6340.49276057905, 6349.3650634937985, 6378.617282963037, 6401.93598064032, 6359.459445947146, 6365.172527571386, 6367.363263673781, 6370.74517019314, 6384.744610215539, 6138.051223665453, 6143.662098584621, 6307.400796924285, 6310.6529140895855, 6316.368363163647, 6032.939670603238, 6185.752569897154, 6276.246850377984, 6294.464970477377, 6338.207724034496, 6135.969320153371, 6139.9079013813935, 6143.84640383994, 6148.139260503623, 6163.876722465615, 6088.695565221809, 6098.969505152446, 6136.7852125175405, 6139.6009259398, 6160.014397696526, 5837.854053648693, 5900.881982360414, 5905.877883202178, 5992.280926288873, 5997.91003134962, 6127.264728232462, 6159.5072394209255, 6166.136740856374, 6170.753169873155, 6181.011038233861, 6005.699715014319, 6048.848778780566, 6054.485368743706, 6104.20645316106, 6142.986407242934], "value": 5766.417930607119, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [458.4200985753021, 467.201086142696, 467.36438443716537, 519.1900635009385, 523.4503771040406, 29284.0, 30608.38783224334, 33003.504947425776, 33019.504707429405, 33100.0, 34184.97445076646, 43707.562924370744, 44178.0, 44632.77683611577, 46292.0, 8542.530160841152, 9716.076972687584, 9735.464549449778, 9867.506624668773, 9888.060634239735, 9781.853272200922, 9893.109620134186, 9893.25800564957, 9901.75245618858, 9905.554250058765, 8776.034636190014, 8982.281417486618, 12077.0, 12299.631011069638, 12344.876551234462, 12312.938435307811, 12349.93825030878, 12357.876421235762, 12362.38188090592, 12386.504539818487, 10322.948385258025, 12111.757764844653, 12171.33057681827, 12200.267983920992, 12211.877881221251, 31793.364132717215, 32200.516992245135, 40976.56582019615, 41115.177696445906, 41266.0, 3399.7280217582534, 3426.8629254829775, 3450.8102054387, 3480.2343484433386, 3724.9813750931344, 28859.27851803701, 29869.850650746823, 30678.69321306803, 30687.693123068708, 31249.687503125133, 3138.8587513561943, 3235.6279027911855, 3242.3353212591596, 3261.5596894419186, 3314.2708604107297, 539804.6019539793, 541304.0, 543489.0, 543601.999999996, 544279.2786036084, 53700.19449708257, 54855.33729632946, 61799.0, 63221.367786322466, 63890.68054659697, 63951.720965580425, 67178.66410668014, 67234.0, 67243.66378168078, 67256.66371668209, 16531.504054878373, 16686.666266674598, 16710.498685039467, 16713.749293760604, 16742.24659890308, 12863.549775757803, 12942.029347798953, 12942.935285323512, 12947.028972827076, 12964.092513524152, 15555.0, 17649.470515884543, 17887.642247154985, 17923.910380448277, 17953.281868725106, 5410.756515956791, 6602.2407423146, 6630.270670226271, 6630.336966303331, 6666.600003999775, 850.4004676702909, 900.4417261298037, 995.6515219673056, 1035.8135535603665, 1071.2019545438698, 29267.414651707273, 30347.544786828214, 30354.84822575917, 30690.389188272988, 30726.539101913488, 919.9080091990882, 1058.30680904008, 1063.803196408667, 1082.691432941608, 1163.2148299897535, 12210.572629958087, 15094.0, 15667.2949717263, 15689.607759806097, 16076.839231607768, 579146.0, 605008.0, 690425.0, 697850.0, 702193.0, 59800.0, 59889.700551496964, 59907.0, 59960.800783984945, 59964.70017649884, 1364.8703373179533, 1377.8415482219673, 1405.943762249519, 1406.9296535173405, 1409.0981771666143, 29134.0, 29217.97737079277, 29755.55366669545, 29788.851055744584, 30391.84804076054, 49393.76515587139, 51460.0, 51816.222756657924, 51873.96252075013, 51958.96082078413, 587304.0, 588194.118058814, 592181.0, 594324.0, 597578.0, 34262.65737342694, 41248.762537123934, 41572.37641435441, 41576.79211603923, 42632.0, 47298.76350618225, 48190.27714584354, 48385.27422088601, 48857.267140992204, 49621.25568116553, 39149.6085039146, 40236.1952760949, 40415.1916961665, 41033.589664102976, 41527.792361038, 33699.32601348008, 35145.64854351424, 38195.809020954715, 39776.60223397845, 40858.0, 38352.42471362876, 38875.222495549366, 39032.804835975636, 39120.21759564849, 40339.79830100948, 26728.732712672623, 34304.0, 36031.63968360388, 36168.638313616524, 36637.45043824398, 25301.240962771146, 26278.343041424116, 26377.68111594451, 26441.206763797116, 26614.467710646066], "value": 20457.80897560316, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [373.0710530778359, 376.8454933477275, 385.3237568068041, 391.32301119064, 404.43783141433414, 19236.13437395317, 21681.80750058746, 21797.237096701618, 22000.88999555002, 22049.559008819815, 20380.490487737814, 20530.281440149596, 21080.578388432223, 21375.144994200215, 21385.2515161969, 5822.359540450547, 5871.3541510433815, 6104.175936248594, 6178.227721534809, 6219.0, 3907.4529565860803, 4048.4736984192014, 6178.7219575119225, 6232.719527621268, 6238.781642642509, 3732.4961130247475, 6110.388961103877, 6233.096201050845, 6250.062490626419, 6251.12484252205, 5965.671888046156, 6142.96928515359, 6202.658853763041, 6229.37706229378, 6250.249970003606, 6020.488258498033, 6028.186194863725, 6031.668258245794, 6032.004719221323, 6040.5469589780505, 13184.077114601982, 13257.867421325856, 13503.864961350457, 13624.0, 13775.448982040807, 2151.7955794199524, 2201.7230006596137, 2242.9887850560644, 2252.0, 2797.6642802863585, 8713.869291960626, 9826.508674566314, 9988.800223995479, 10031.0, 10574.10120139789, 1841.327915310902, 1880.990595047016, 1921.193098898466, 1979.3072424651257, 1980.0396807548327, 105380.0, 126576.0, 131911.34044329813, 135418.999999999, 136793.3160334192, 9777.46223957675, 10316.019978102067, 11551.884481155248, 11655.358955257543, 11827.586034488751, 14881.10713357202, 14883.851161488463, 14890.702185956221, 14904.925475372555, 14906.552803415914, 7036.19083805369, 8667.826643467095, 8679.783005424915, 8719.782005449788, 8789.252913502296, 8603.741887743377, 8627.482351058956, 8772.210501054935, 8796.252318552866, 8844.115588441104, 4435.2016637005, 4565.977170114128, 4568.771561421916, 4577.198990176706, 4645.767711614406, 1615.3700056977552, 1732.4023211991844, 1836.8714190006572, 1895.365052707331, 1900.7148927660962, 600.1837500998638, 714.2678754276908, 844.0462277626366, 928.9163975242261, 951.6669165791917, 17168.141592920303, 21822.563459106295, 21858.01638926252, 21872.45318867041, 21947.561048778934, 867.8823670244583, 943.9575219115156, 994.4530508220449, 1036.549101141006, 1054.362110922896, 11032.834507482394, 11253.887461125447, 11311.34183466901, 11668.0, 11689.064874809996, 619771.9011405004, 632659.0, 639887.0, 642378.0, 655075.0, 139449.0, 141791.0, 142187.0, 146450.0, 153369.0, 988.9357191782511, 992.161623428202, 1008.1934452438167, 1011.489197955028, 1012.3015119567475, 15945.68108637844, 18551.35070272534, 19174.424767257005, 19257.4222773317, 19405.8059419404, 54003.0, 55636.88726225534, 56534.43465565292, 56715.86568268529, 57014.42985570091, 67687.0, 81972.77040844272, 84624.57687711522, 85335.29329413502, 89298.0, 5544.972275138599, 8120.390970677341, 8175.67297308101, 8296.83406331882, 8443.831123377375, 11201.0, 13139.802902956271, 13354.265515396746, 13555.932220338835, 13640.454381824617, 11349.432528373713, 11599.130065244972, 11671.941640291745, 11926.701832454259, 11995.980341670707, 11472.770544589228, 11474.139439542234, 11817.763644726885, 11829.940850295694, 12069.0, 11403.201775875608, 11743.354115523387, 11798.587049453572, 11806.763864722485, 12194.024478041558, 8083.474574152897, 8169.305609023299, 8431.704890328809, 8501.234888860032, 8543.359248056297, 9690.0, 10244.795104098026, 11189.04893084097, 11602.70993225176, 11811.468483918416], "value": 9551.084176222386, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1502.2638906935601, 1521.6348076461647, 1681.7981842178933, 1801.2344753479767, 1839.5493104189475, 8461.196186362293, 9024.684136055248, 9034.90965090349, 9059.864102038475, 9096.68161614342, 7856.17510161432, 8083.353331733462, 8085.716999905005, 8194.016717993849, 8790.51652159131, 2170.0994087453687, 2208.8012078912893, 2326.0695721711368, 2403.8197135214928, 2407.9759202408013, 2405.518896220754, 2407.3981504623844, 2409.3976505873534, 2410.1323523531514, 2410.602250628644, 2362.0669835415, 2400.3759022654062, 2411.336882357357, 2413.5655581995234, 2479.2686157583557, 2363.8108951283943, 2376.7623237676266, 2389.892454839536, 2394.4253379188867, 2394.760523947609, 2366.3847399676038, 2372.2290255666803, 2374.81001519878, 2391.8086553075887, 2398.8080953523677, 8871.334649901282, 8943.0, 8952.776180595472, 8977.820443591092, 8996.100389961017, 5267.525922666979, 5434.239206511092, 5440.238366628675, 5446.128619420873, 5451.3458384993655, 3582.659647333499, 3662.908427289339, 3758.285925674113, 3761.567419746737, 3765.6046115157787, 912.3567884641312, 1113.3264375053138, 1118.2619471149085, 1751.1681951073265, 1806.3948577226645, 11587.362695051768, 11638.243514171552, 11691.590794322157, 11701.53193872244, 11716.53133874644, 3365.9663403366144, 4467.687261891637, 4697.365855609517, 4700.271457924027, 4711.3639658646325, 9136.040715724886, 9142.177204051533, 9152.0, 9157.954210228907, 9158.129977652112, 5200.765965531485, 5272.103742363807, 5299.682019078868, 5310.256564081032, 5323.547498462596, 4815.133276010351, 4893.241547560134, 4953.7523123844385, 4968.056069346812, 4971.925421118686, 3547.5742910850345, 3679.8896033118513, 3769.7172712046704, 3888.358420860583, 3889.2999260132883, 992.2111921022804, 1011.1556850030307, 1173.8884805943592, 1176.0591526778715, 1185.6917201527665, 787.5353541410595, 863.7624653220289, 899.5637115998735, 902.6885724425063, 916.8945571259391, 5666.518345940559, 5673.886522269614, 5728.914066289009, 5925.0, 6150.354212807681, 946.3564775952418, 953.208836665566, 956.9473678947586, 977.237754551451, 996.0139461932635, 3892.4745159403683, 3921.7254792164845, 3948.269570129478, 4055.6349928506575, 4072.124493233969, 10455.84316235257, 10887.510062047228, 10896.346219226873, 10900.0, 10917.017468427879, 10444.791104178026, 10839.0, 10846.0, 10855.945720271347, 10874.184436167161, 7963.243491868379, 8267.0, 8277.089520152778, 8287.917120828835, 8305.792355191048, 5131.819681473207, 5624.971875140598, 5767.769289228384, 5799.536037116936, 5943.791967281124, 9949.552270147717, 10082.949585252027, 10222.0289072538, 10251.436171010666, 10269.127124194229, 9741.853872192065, 10204.2346823987, 10540.525676344736, 10541.525631346454, 10572.84140737905, 7163.677634506564, 7248.420126389981, 7254.927450725636, 7263.346298832919, 7263.4915555910575, 7622.809429764078, 7857.685692572233, 7874.0, 7947.841043178988, 7974.122846486765, 6938.722451101899, 7257.455690823103, 7516.135644400745, 7526.134494533198, 7573.129090154483, 7337.1929087799235, 7348.485606007528, 7372.078490188726, 7437.665305061393, 7487.513311634726, 6792.694328755119, 6849.1438570178725, 6919.481038922, 6924.0, 6929.549579277331, 4895.363602731764, 4903.239997800347, 5007.349044624176, 5024.6231532634465, 5174.6119041072825, 4943.728094954812, 4966.230234313687, 4971.453140154653, 5024.899502010013, 5067.391912970467], "value": 4590.4055790541015, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [300.21493793729405, 303.2176983382872, 310.2151556561898, 314.2771625261897, 316.13379340606747, 5072.619553533481, 5224.268602395668, 5248.6063545234065, 5272.604554658402, 5297.44376840432, 4998.800047998076, 5140.794368225266, 5172.405178401013, 5196.402413722423, 5211.5049070338355, 4026.5772093930154, 4032.354823228284, 4045.8786236412957, 4060.451839001734, 4060.776657283848, 3869.496965394509, 3972.304846651839, 4070.2266569351727, 4079.8368065277355, 4125.7524548527035, 3801.3537698591167, 3890.591487893773, 3896.8246428910766, 4000.3399439092514, 4018.7789671568053, 3294.8846790362463, 3314.4199765041144, 3946.960530394717, 3957.3668213085766, 3982.940255896149, 3300.042987533612, 3353.6814002669707, 3475.402957938547, 3490.284491679225, 3506.789592624425, 4144.254034273829, 4459.996500787297, 4612.607928326096, 4657.86026419208, 5101.770420331094, 4560.749158796265, 4574.4510658721165, 4577.748223847687, 4584.977075114636, 4617.976910115428, 4842.02215637384, 5017.874553136165, 5111.08000559899, 5504.146857237135, 5530.834074977717, 3697.500837386945, 3754.8597299539274, 3759.0602349412648, 3845.4616353710503, 3887.3974533947285, 4966.498618473967, 5126.871828204325, 5723.198752174699, 5762.798302059407, 5832.912506312408, 3321.933561328808, 3875.779129574175, 3877.3602355611574, 3894.824732887027, 3912.256671232514, 3244.9291733727814, 3321.568196134487, 3830.2339532093692, 3900.3564411871725, 3987.401889716508, 3793.918733161091, 3795.35478968576, 4194.951262184454, 4358.101862261624, 4595.770211489412, 4830.806767729322, 5494.2857428534035, 5519.530839878575, 5520.66875987434, 5522.502974732213, 1274.3118715893313, 1329.5745361484426, 1361.7072329449018, 1366.685662297677, 1366.8906487480979, 770.8805135203941, 785.9331956783737, 839.9790005249918, 840.8774286327821, 861.9225967540574, 4345.609914546986, 4346.80486354389, 4357.69269219233, 4379.0585024219945, 4383.7642802170485, 4712.010477799632, 4739.786709598076, 4758.381410416624, 4822.614190864722, 4838.540338667821, 4198.685098617616, 4305.547917468683, 4619.5611416915335, 5030.37120359955, 5179.326687530597, 2755.2147637923094, 2956.911292661224, 2980.687027862087, 2993.0721476342405, 3000.4149190907565, 4948.727819969936, 5424.593155513352, 5717.599768016199, 5888.440598143169, 5904.557158213065, 5776.469235652556, 5827.3298570664065, 5830.47525722687, 5861.3552509223955, 5886.940350736822, 5154.92267615986, 5346.19807028941, 5881.9705901470215, 5918.644881307136, 5931.406859314034, 4521.706089104197, 4988.9251661225835, 5322.707251101227, 5682.744276507649, 5703.691858722014, 4738.360321356573, 4757.3577567028005, 4781.115493633689, 5557.805476808292, 5613.550915926798, 4690.92963605553, 5211.254229833048, 5614.9719251403485, 5891.3224979127945, 5906.527477801851, 3611.9458208127426, 3843.7501562398356, 3879.9224015520094, 3899.668528175137, 3901.45379646844, 5253.894922101613, 5733.512651424676, 5765.538756899522, 5773.595848290579, 5839.240898683144, 5627.240322556566, 5648.943510564842, 5671.412004638708, 5671.574631902541, 5699.658020518782, 4782.282657601388, 4820.939393333461, 5286.62993590445, 5565.3599836019375, 5576.944230557642, 4248.596383343577, 5463.890722185454, 5477.726113694379, 5501.917471237854, 5547.4175211603815, 5265.868353291198, 5519.97042159218, 5610.85972850682, 5626.043572592751, 5637.646964728354, 4494.483134439451, 5457.0, 5486.61593688438, 5501.2121060654645, 5590.916136257878], "value": 3979.132770035316, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [617.6078190349128, 703.3810246982657, 779.9142094369622, 797.9321757650599, 811.3792948394479, 14800.333984970675, 15442.0, 15997.760033599476, 16020.519384418472, 16522.0, 11763.176577639568, 12231.877681223184, 12403.813942790865, 12405.007599392049, 12433.875661243408, 678.5792808458763, 696.0811728518357, 846.369454756206, 872.8036191856813, 874.3748220022683, 841.3017195727562, 859.3168431097292, 869.7260362985639, 880.6037283222576, 882.3779235638859, 918.2608000559546, 919.4207649181006, 920.9593159729529, 923.9260859131253, 924.6717415317567, 716.5414134953634, 747.5664114813395, 916.2990312410977, 920.3327587499043, 921.4885738415177, 559.980400685974, 561.5816216918381, 561.8763871948165, 654.6693919570635, 681.7750142452978, 15160.620984475367, 15172.468963586221, 15285.694286114327, 15296.847031529765, 15321.157336346496, 13958.0, 14197.787033194407, 14287.357068931922, 14372.568822935329, 14589.270536473134, 12283.631491055283, 12325.0, 12438.440270187863, 13105.082644214908, 13400.932995335059, 4499.797509112098, 4585.082983403333, 4664.55686709762, 4669.439667239919, 4759.381280433521, 101873.9812601872, 104688.47655761748, 116532.0, 118762.0, 123502.0, 10400.375977441226, 10972.01251887334, 11019.779604407868, 11210.775784484427, 11274.605388811517, 21997.340079797632, 22036.779632203474, 22041.448963776034, 22042.44893877634, 22043.228487002878, 7664.156942736295, 7767.067951845815, 7772.7668169954995, 7909.5649739263745, 8037.678492860337, 4366.541513141138, 4379.868603941887, 4461.531539188403, 4514.435695538058, 4583.977080114578, 3197.552342672028, 3448.2930999145615, 3509.385682586039, 3594.694450971697, 3598.604153543108, 631.0938129911782, 648.8280605639509, 658.8319978405476, 667.679513833353, 668.7893313606198, 599.0, 614.3948211012149, 615.879903418838, 619.0, 620.8975519039308, 8954.641814327353, 9207.63169473227, 9208.401453905475, 9283.90716092844, 9319.440833550008, 584.6755050946765, 595.976160953557, 612.1980205930246, 616.2912650452016, 637.5562330556018, 4327.653787696977, 4491.887702807456, 4504.234280172379, 4514.210013247669, 4517.954820451753, 162163.56754648688, 167483.1625841863, 171337.0, 175773.0, 179790.1010494939, 113357.73284534428, 116087.0, 116722.24916626257, 120764.0, 121531.0, 75820.0, 77859.22140778633, 101174.99999999853, 101732.49133754284, 119798.80201197877, 9343.252539796664, 9899.802003959736, 9972.451515166735, 9992.550335235077, 10045.849312260176, 56381.71809140928, 61086.38913610807, 61998.070028950504, 62734.68632656807, 62789.0, 80629.0, 83759.0, 96014.51992739992, 99623.0, 100685.4965725196, 13397.53108641193, 13812.378442970292, 13821.723565528835, 13889.791653125008, 14363.497277595234, 14055.508057217949, 14990.775138373152, 15181.0, 15257.08457492554, 15316.310766015333, 13796.0, 13923.164610123426, 13954.58136255914, 14237.288135592971, 14238.786418203528, 12960.675983100498, 13449.86550134486, 14641.780373294196, 14666.413343466142, 15100.39598416051, 11544.422778860855, 12949.223046617233, 13477.595672129852, 14501.492447764278, 14538.781918271023, 11404.885951140383, 11518.0, 11671.708207294885, 11996.64010079699, 12296.0, 11586.420678966186, 11771.646850594496, 11852.466639001437, 11866.466009029788, 11901.702457438634], "value": 7848.959032826758, "unit": "score"}], "name": "dromaeo_css", "value": 7379.941329618375, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 114.0, 121.0, 166.0, 152.0, 114.0, 114.0, 112.0, 115.0], "value": 123.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 107.0, 112.0, 174.0, 140.0, 111.0, 109.0, 108.0, 156.0, 134.0], "value": 129.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 184.0, 185.0, 187.0, 184.0, 186.0, 184.0, 183.0, 185.0, 185.0], "value": 184.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 59.0, 57.0, 89.0, 65.0, 58.0, 58.0, 58.0, 81.0, 56.0], "value": 66.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 70.0, 94.0, 69.0, 68.0, 69.0, 92.0, 68.0, 90.0, 124.0], "value": 83.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 100.0, 88.0, 86.0, 88.0, 85.0, 92.0, 86.0, 88.0, 85.0], "value": 88.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 168.0, 163.0, 96.0, 100.0, 98.0, 100.0, 169.0, 98.0, 148.0], "value": 125.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 103.0, 124.0, 139.0, 134.0, 85.0, 86.0, 86.0, 85.0, 85.0], "value": 101.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 53.0, 53.0, 55.0, 56.0, 58.0, 58.0, 58.0, 58.0, 58.0], "value": 56.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 70.0, 71.0, 73.0, 72.0, 68.0, 69.0, 67.0, 73.0, 100.0], "value": 72.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 84.0, 85.0, 82.0, 82.0, 83.0, 82.0, 84.0, 86.0, 84.0], "value": 83.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 140.0, 138.0, 137.0, 139.0, 142.0, 142.0, 137.0, 170.0, 138.0], "value": 142.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 167.0, 167.0, 202.0, 230.0, 202.0, 172.0, 168.0, 167.0, 167.0], "value": 180.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 67.0, 66.0, 65.0, 67.0, 67.0, 67.0, 67.0, 66.0], "value": 66.7, "unit": "score"}], "name": "kraken", "value": 1505.1000000000004, "alertThreshold": 2.0}]} 06:06:09 INFO - Return code: 0 06:06:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:06:09 INFO - # TBPL SUCCESS # 06:06:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:06:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:06:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:06:09 INFO - 2016-10-13 06:06:09.906 screenresolution[1669:10148] starting screenresolution argv=screenresolution get 06:06:09 INFO - 2016-10-13 06:06:09.908 screenresolution[1669:10148] Display 0: 1600x1200x32@60 06:06:09 INFO - 2016-10-13 06:06:09.914 screenresolution[1670:10151] starting screenresolution argv=screenresolution list 06:06:09 INFO - Available Modes on Display 0 06:06:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:06:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:06:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:06:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:06:10 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:06:10 INFO - Intel Iris: 06:06:10 INFO - Chipset Model: Intel Iris 06:06:10 INFO - Type: GPU 06:06:10 INFO - Bus: Built-In 06:06:10 INFO - VRAM (Dynamic, Max): 1536 MB 06:06:10 INFO - Vendor: Intel (0x8086) 06:06:10 INFO - Device ID: 0x0a2e 06:06:10 INFO - Revision ID: 0x0009 06:06:10 INFO - Displays: 06:06:10 INFO - Display: 06:06:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:06:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:06:10 INFO - Display Serial Number: 1600x1200 60 06:06:10 INFO - Main Display: Yes 06:06:10 INFO - Mirror: Off 06:06:10 INFO - Online: Yes 06:06:10 INFO - Rotation: Supported 06:06:10 INFO - Return code: 0 06:06:10 INFO - Running post-action listener: _resource_record_post_action 06:06:10 INFO - [mozharness: 2016-10-13 13:06:10.149861Z] Finished run-tests step (success) 06:06:10 INFO - Running post-run listener: _resource_record_post_run 06:06:10 INFO - Total resource usage - Wall time: 1209s; CPU: 53.0%; Read bytes: 38532096; Write bytes: 664112128; Read time: 381; Write time: 2113 06:06:10 INFO - TinderboxPrint: CPU usage
53.5% 06:06:10 INFO - TinderboxPrint: I/O read bytes / time
38,532,096 / 381 06:06:10 INFO - TinderboxPrint: I/O write bytes / time
664,112,128 / 2,113 06:06:10 INFO - TinderboxPrint: CPU idle
2,249.7 (46.5%) 06:06:10 INFO - TinderboxPrint: CPU system
968.8 (20.0%) 06:06:10 INFO - TinderboxPrint: CPU user
1,619.2 (33.5%) 06:06:10 INFO - TinderboxPrint: Swap in / out
401,809,408 / 0 06:06:10 INFO - install - Wall time: 33s; CPU: 55.0%; Read bytes: 363627008; Write bytes: 355620352; Read time: 27663; Write time: 716 06:06:10 INFO - run-tests - Wall time: 1177s; CPU: 53.0%; Read bytes: 31423488; Write bytes: 297469440; Read time: 299; Write time: 1370 06:06:10 INFO - Running post-run listener: _upload_blobber_files 06:06:10 INFO - Blob upload gear active. 06:06:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:06:10 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 06:06:10 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'] 06:06:10 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 06:06:11 INFO - (blobuploader) - INFO - Open directory for files ... 06:06:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:06:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:06:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:06:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:06:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:06:12 INFO - (blobuploader) - INFO - Done attempting. 06:06:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:06:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:06:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:06:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:06:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:06:13 INFO - (blobuploader) - INFO - Done attempting. 06:06:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:06:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:06:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:06:15 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:06:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:06:15 INFO - (blobuploader) - INFO - Done attempting. 06:06:15 INFO - (blobuploader) - INFO - Iteration through files over. 06:06:15 INFO - Return code: 0 06:06:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:06:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:06:15 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cf84c0e5bd4166947cb69d6389582fd87a68d8f9e265b152b6e129a9967245cbf39cfe03930839e89a49d32a6fbc30357363b2ef196b3a0b2f839ef326a736fa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dbe5dcdce7dfe8a260615f4648c832a8fd0b35a676ab65fb276769f5b15cfb8e579372770f946dbf06c36d00b3db96b42be54a1444897f2b7a52b7e9136995e8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/efc1826002ee3c1bb3880d3a96584cee13c4c431762c69ac5df254ef160e0ae8382e99c0bb8de9075838b426ff85f27e6d73a9479d0b640569346834e71f04d9"} 06:06:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:06:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:06:15 INFO - Contents: 06:06:15 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cf84c0e5bd4166947cb69d6389582fd87a68d8f9e265b152b6e129a9967245cbf39cfe03930839e89a49d32a6fbc30357363b2ef196b3a0b2f839ef326a736fa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dbe5dcdce7dfe8a260615f4648c832a8fd0b35a676ab65fb276769f5b15cfb8e579372770f946dbf06c36d00b3db96b42be54a1444897f2b7a52b7e9136995e8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/efc1826002ee3c1bb3880d3a96584cee13c4c431762c69ac5df254ef160e0ae8382e99c0bb8de9075838b426ff85f27e6d73a9479d0b640569346834e71f04d9"} 06:06:15 INFO - Running post-run listener: copy_logs_to_upload_dir 06:06:15 INFO - Copying logs to upload dir... 06:06:15 INFO - mkdir: /builds/slave/test/build/upload/logs 06:06:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1271.150893 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-10-13 06:06:15.723874) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-13 06:06:15.727205) ========= 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.N7ObjJ66Rn/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.ircv91anVk/Listeners TMPDIR=/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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/cf84c0e5bd4166947cb69d6389582fd87a68d8f9e265b152b6e129a9967245cbf39cfe03930839e89a49d32a6fbc30357363b2ef196b3a0b2f839ef326a736fa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dbe5dcdce7dfe8a260615f4648c832a8fd0b35a676ab65fb276769f5b15cfb8e579372770f946dbf06c36d00b3db96b42be54a1444897f2b7a52b7e9136995e8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/efc1826002ee3c1bb3880d3a96584cee13c4c431762c69ac5df254ef160e0ae8382e99c0bb8de9075838b426ff85f27e6d73a9479d0b640569346834e71f04d9"} build_url:https://queue.taskcluster.net/v1/task/PNg4obGWRdmfeP-cK4RCnQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010921 build_url: 'https://queue.taskcluster.net/v1/task/PNg4obGWRdmfeP-cK4RCnQ/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/cf84c0e5bd4166947cb69d6389582fd87a68d8f9e265b152b6e129a9967245cbf39cfe03930839e89a49d32a6fbc30357363b2ef196b3a0b2f839ef326a736fa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dbe5dcdce7dfe8a260615f4648c832a8fd0b35a676ab65fb276769f5b15cfb8e579372770f946dbf06c36d00b3db96b42be54a1444897f2b7a52b7e9136995e8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/efc1826002ee3c1bb3880d3a96584cee13c4c431762c69ac5df254ef160e0ae8382e99c0bb8de9075838b426ff85f27e6d73a9479d0b640569346834e71f04d9"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-13 06:06:15.759021) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 06:06:15.759342) ========= 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.N7ObjJ66Rn/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.ircv91anVk/Listeners TMPDIR=/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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.005041 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 06:06:15.807686) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-13 06:06:15.808010) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-13 06:06:15.808341) ========= ========= Total master_lag: 0.17 =========