builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0163 starttime: 1478263946.75 results: success (0) buildid: 20161104032020 builduid: 49bd59affabd46b5956661c14dc8ca95 revision: 1a8ed7ba82adecdd095ae3d7d99bcf672ef7e976 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-04 05:52:26.745540) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-04 05:52:26.745946) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-04 05:52:26.746230) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-04 05:52:26.769713) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-04 05:52:26.770417) ========= 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.eMKAMV9gzh/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.ij8uOpdQv5/Listeners TMPDIR=/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-11-04 05:52:26-- 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% 8.23M=0.001s 2016-11-04 05:52:26 (8.23 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.117647 ========= master_lag: 0.23 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-04 05:52:27.118191) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-04 05:52:27.118499) ========= 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.eMKAMV9gzh/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.ij8uOpdQv5/Listeners TMPDIR=/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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.020027 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-04 05:52:27.159277) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-04 05:52:27.159581) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 1a8ed7ba82adecdd095ae3d7d99bcf672ef7e976 --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 1a8ed7ba82adecdd095ae3d7d99bcf672ef7e976 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.eMKAMV9gzh/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.ij8uOpdQv5/Listeners TMPDIR=/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-11-04 05:52:27,238 truncating revision to first 12 chars 2016-11-04 05:52:27,238 Setting DEBUG logging. 2016-11-04 05:52:27,238 attempt 1/10 2016-11-04 05:52:27,238 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/1a8ed7ba82ad?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-04 05:52:27,626 unpacking tar archive at: mozilla-aurora-1a8ed7ba82ad/testing/mozharness/ program finished with exit code 0 elapsedTime=0.678688 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-04 05:52:27.863697) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-04 05:52:27.864487) ========= script_repo_revision: 1a8ed7ba82adecdd095ae3d7d99bcf672ef7e976 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-04 05:52:27.865244) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-04 05:52:27.865892) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-04 05:52:27.886152) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-11-04 05:52:27.886655) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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.eMKAMV9gzh/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.ij8uOpdQv5/Listeners TMPDIR=/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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:52:28 INFO - MultiFileLogger online at 20161104 05:52:28 in /builds/slave/test 05:52:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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:52:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:52:28 INFO - {'append_to_log': False, 05:52:28 INFO - 'base_work_dir': '/builds/slave/test', 05:52:28 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 05:52:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:52:28 INFO - 'branch': 'Mozilla-Aurora', 05:52:28 INFO - 'buildbot_json_path': 'buildprops.json', 05:52:28 INFO - 'config_files': ('talos/mac_config.py',), 05:52:28 INFO - 'default_actions': ('clobber', 05:52:28 INFO - 'read-buildbot-config', 05:52:28 INFO - 'download-and-extract', 05:52:28 INFO - 'populate-webroot', 05:52:28 INFO - 'create-virtualenv', 05:52:28 INFO - 'install', 05:52:28 INFO - 'run-tests'), 05:52:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:52:28 INFO - 'download_minidump_stackwalk': True, 05:52:28 INFO - 'download_symbols': 'ondemand', 05:52:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:52:28 INFO - 'tooltool.py': '/tools/tooltool.py', 05:52:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:52:28 INFO - '/tools/misc-python/virtualenv.py')}, 05:52:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:52:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:52:28 INFO - 'installer_path': 'installer.exe', 05:52:28 INFO - 'log_level': 'info', 05:52:28 INFO - 'log_name': 'talos', 05:52:28 INFO - 'log_to_console': True, 05:52:28 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:52:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:52:28 INFO - 'opt_config_files': (), 05:52:28 INFO - 'pip_index': False, 05:52:28 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:52:28 INFO - 'cmd': ('bash', 05:52:28 INFO - '-c', 05:52:28 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:52:28 INFO - 'enabled': True, 05:52:28 INFO - 'halt_on_failure': False, 05:52:28 INFO - 'name': 'check_screen_resolution'},), 05:52:28 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:52:28 INFO - 'cmd': ('bash', 05:52:28 INFO - '-c', 05:52:28 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:52:28 INFO - 'enabled': True, 05:52:28 INFO - 'halt_on_failure': False, 05:52:28 INFO - 'name': 'check_screen_resolution'},), 05:52:28 INFO - 'run_cmd_checks_enabled': True, 05:52:28 INFO - 'sps_profile': False, 05:52:28 INFO - 'sps_profile_interval': 0, 05:52:28 INFO - 'suite': 'dromaeojs-e10s', 05:52:28 INFO - 'system_bits': '32', 05:52:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:52:28 INFO - 'title': 't-yosemite-r7-0163', 05:52:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:52:28 INFO - 'use_talos_json': True, 05:52:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:52:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:52:28 INFO - 'work_dir': 'build'} 05:52:28 INFO - [mozharness: 2016-11-04 12:52:28.086441Z] Running clobber step. 05:52:28 INFO - Running pre-action listener: _resource_record_pre_action 05:52:28 INFO - Running main action method: clobber 05:52:28 INFO - rmtree: /builds/slave/test/build 05:52:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:52:28 INFO - Running post-action listener: _resource_record_post_action 05:52:28 INFO - [mozharness: 2016-11-04 12:52:28.591527Z] Finished clobber step (success) 05:52:28 INFO - [mozharness: 2016-11-04 12:52:28.591656Z] Running read-buildbot-config step. 05:52:28 INFO - Running pre-action listener: _resource_record_pre_action 05:52:28 INFO - Running main action method: read_buildbot_config 05:52:28 INFO - Using buildbot properties: 05:52:28 INFO - { 05:52:28 INFO - "project": "", 05:52:28 INFO - "product": "firefox", 05:52:28 INFO - "script_repo_revision": "production", 05:52:28 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 05:52:28 INFO - "repository": "", 05:52:28 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 05:52:28 INFO - "buildid": "20161104032020", 05:52:28 INFO - "pgo_build": "False", 05:52:28 INFO - "basedir": "/builds/slave/test", 05:52:28 INFO - "buildnumber": 2, 05:52:28 INFO - "slavename": "t-yosemite-r7-0163", 05:52:28 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 05:52:28 INFO - "platform": "yosemite_r7", 05:52:28 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 05:52:28 INFO - "branch": "mozilla-aurora", 05:52:28 INFO - "repo_path": "releases/mozilla-aurora", 05:52:28 INFO - "revision": "1a8ed7ba82adecdd095ae3d7d99bcf672ef7e976", 05:52:28 INFO - "stage_platform": "macosx64", 05:52:28 INFO - "builduid": "49bd59affabd46b5956661c14dc8ca95", 05:52:28 INFO - "slavebuilddir": "test" 05:52:28 INFO - } 05:52:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/bem3mmm3QYCTLOOtaNv64g/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 05:52:28 INFO - Running post-action listener: _resource_record_post_action 05:52:28 INFO - [mozharness: 2016-11-04 12:52:28.594982Z] Finished read-buildbot-config step (success) 05:52:28 INFO - [mozharness: 2016-11-04 12:52:28.595123Z] Running download-and-extract step. 05:52:28 INFO - Running pre-action listener: _resource_record_pre_action 05:52:28 INFO - Running main action method: download_and_extract 05:52:28 INFO - mkdir: /builds/slave/test/build/tests 05:52:28 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:52:28 INFO - trying https://queue.taskcluster.net/v1/task/bem3mmm3QYCTLOOtaNv64g/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 05:52:28 INFO - Downloading https://queue.taskcluster.net/v1/task/bem3mmm3QYCTLOOtaNv64g/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:52:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bem3mmm3QYCTLOOtaNv64g/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:52:29 INFO - Downloaded 1199 bytes. 05:52:29 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 05:52:29 INFO - Using the following test package requirements: 05:52:29 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 05:52:29 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 05:52:29 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 05:52:29 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 05:52:29 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 05:52:29 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 05:52:29 INFO - u'jsshell-mac.zip'], 05:52:29 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 05:52:29 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 05:52:29 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 05:52:29 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 05:52:29 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 05:52:29 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 05:52:29 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 05:52:29 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 05:52:29 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 05:52:29 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 05:52:29 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 05:52:29 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 05:52:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bem3mmm3QYCTLOOtaNv64g/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 05:52:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bem3mmm3QYCTLOOtaNv64g/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 05:52:29 INFO - Fetch https://queue.taskcluster.net/v1/task/bem3mmm3QYCTLOOtaNv64g/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 05:52:30 INFO - Expected file size: 16421520 05:52:37 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:52:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bem3mmm3QYCTLOOtaNv64g/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 05:52:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bem3mmm3QYCTLOOtaNv64g/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 05:52:37 INFO - Fetch https://queue.taskcluster.net/v1/task/bem3mmm3QYCTLOOtaNv64g/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 05:52:37 INFO - Expected file size: 16421520 05:52:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bem3mmm3QYCTLOOtaNv64g/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 05:52:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bem3mmm3QYCTLOOtaNv64g/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 05:52:44 INFO - Fetch https://queue.taskcluster.net/v1/task/bem3mmm3QYCTLOOtaNv64g/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 05:52:45 INFO - Expected file size: 14414089 05:52:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:46 INFO - trying https://queue.taskcluster.net/v1/task/bem3mmm3QYCTLOOtaNv64g/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 05:52:46 INFO - Downloading https://queue.taskcluster.net/v1/task/bem3mmm3QYCTLOOtaNv64g/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 05:52:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bem3mmm3QYCTLOOtaNv64g/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:52:49 INFO - Downloaded 115447479 bytes. 05:52:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bem3mmm3QYCTLOOtaNv64g/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 05:52:49 INFO - mkdir: /builds/slave/test/properties 05:52:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:52:49 INFO - Writing to file /builds/slave/test/properties/build_url 05:52:49 INFO - Contents: 05:52:49 INFO - build_url:https://queue.taskcluster.net/v1/task/bem3mmm3QYCTLOOtaNv64g/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 05:52:50 INFO - Running post-action listener: _resource_record_post_action 05:52:50 INFO - Running post-action listener: set_extra_try_arguments 05:52:50 INFO - [mozharness: 2016-11-04 12:52:50.018867Z] Finished download-and-extract step (success) 05:52:50 INFO - [mozharness: 2016-11-04 12:52:50.019015Z] Running populate-webroot step. 05:52:50 INFO - Running pre-action listener: _resource_record_pre_action 05:52:50 INFO - Running main action method: populate_webroot 05:52:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:52:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:52:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:52:50 INFO - '--tppagecycles', 05:52:50 INFO - '7'], 05:52:50 INFO - 'tests': ['tsvgm']}}, 05:52:50 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:52:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:52:50 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:52:50 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:52:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:52:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:52:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:50 INFO - 'talos_options': ['--disable-e10s'], 05:52:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:52:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:52:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:50 INFO - 'talos_options': ['--disable-e10s'], 05:52:50 INFO - 'tests': ['damp', 'tps']}, 05:52:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:50 INFO - 'tests': ['damp', 'tps']}, 05:52:50 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:52:50 INFO - 'tests': ['dromaeo_dom']}, 05:52:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:52:50 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:52:50 INFO - 'tests': ['basic_compositor_video']}, 05:52:50 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:52:50 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:52:50 INFO - 'tests': ['a11yr', 05:52:50 INFO - 'ts_paint', 05:52:50 INFO - 'tpaint', 05:52:50 INFO - 'sessionrestore', 05:52:50 INFO - 'sessionrestore_no_auto_restore', 05:52:50 INFO - 'tabpaint']}, 05:52:50 INFO - 'other-e10s': {'tests': ['a11yr', 05:52:50 INFO - 'ts_paint', 05:52:50 INFO - 'tpaint', 05:52:50 INFO - 'sessionrestore', 05:52:50 INFO - 'sessionrestore_no_auto_restore', 05:52:50 INFO - 'tabpaint']}, 05:52:50 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:52:50 INFO - 'ts_paint', 05:52:50 INFO - 'tpaint', 05:52:50 INFO - 'sessionrestore', 05:52:50 INFO - 'sessionrestore_no_auto_restore', 05:52:50 INFO - 'tabpaint']}, 05:52:50 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:52:50 INFO - 'ts_paint', 05:52:50 INFO - 'tpaint', 05:52:50 INFO - 'sessionrestore', 05:52:50 INFO - 'sessionrestore_no_auto_restore', 05:52:50 INFO - 'tabpaint']}, 05:52:50 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:52:50 INFO - 'tests': ['a11yr', 05:52:50 INFO - 'ts_paint', 05:52:50 INFO - 'tpaint', 05:52:50 INFO - 'sessionrestore', 05:52:50 INFO - 'sessionrestore_no_auto_restore', 05:52:50 INFO - 'tabpaint']}, 05:52:50 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:52:50 INFO - 'tests': ['a11yr', 05:52:50 INFO - 'ts_paint', 05:52:50 INFO - 'tpaint', 05:52:50 INFO - 'sessionrestore', 05:52:50 INFO - 'sessionrestore_no_auto_restore', 05:52:50 INFO - 'tabpaint']}, 05:52:50 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:52:50 INFO - 'tests': ['tsvgx', 05:52:50 INFO - 'tsvgr_opacity', 05:52:50 INFO - 'tart', 05:52:50 INFO - 'tscrollx', 05:52:50 INFO - 'cart']}, 05:52:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:52:50 INFO - 'tsvgr_opacity', 05:52:50 INFO - 'tart', 05:52:50 INFO - 'tscrollx', 05:52:50 INFO - 'cart']}, 05:52:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:50 INFO - 'talos_options': ['--disable-e10s'], 05:52:50 INFO - 'tests': ['tp5o']}, 05:52:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:50 INFO - 'tests': ['tp5o']}, 05:52:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:50 INFO - 'talos_options': ['--disable-e10s', 05:52:50 INFO - '--xperf_path', 05:52:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:52:50 INFO - 'tests': ['tp5n']}, 05:52:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:50 INFO - 'talos_options': ['--xperf_path', 05:52:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:52:50 INFO - 'tests': ['tp5n']}}, 05:52:50 INFO - 'talos.zip': {'path': '', 05:52:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:52:50 INFO - Running post-action listener: _resource_record_post_action 05:52:50 INFO - [mozharness: 2016-11-04 12:52:50.037981Z] Finished populate-webroot step (success) 05:52:50 INFO - [mozharness: 2016-11-04 12:52:50.038092Z] Running create-virtualenv step. 05:52:50 INFO - Running pre-action listener: _resource_record_pre_action 05:52:50 INFO - Running main action method: create_virtualenv 05:52:50 INFO - Creating virtualenv /builds/slave/test/build/venv 05:52:50 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:52:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:52:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:52:50 INFO - Using real prefix '/tools/python27' 05:52:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:52:50 INFO - Installing distribute.............................................................................................................................................................................................done. 05:52:53 INFO - Installing pip.................done. 05:52:53 INFO - Return code: 0 05:52:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:52:53 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:52:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:53 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:52:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:53 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 0x10fa66490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f9dc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ec1cd4640>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f87ad30>, '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 0x10f6e0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f872b20>, '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.eMKAMV9gzh/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.ij8uOpdQv5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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:52:53 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:52:53 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:52:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eMKAMV9gzh/Render', 05:52:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:52:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:52:53 INFO - 'HOME': '/Users/cltbld', 05:52:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:52:53 INFO - 'LOGNAME': 'cltbld', 05:52:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:53 INFO - 'MOZ_NO_REMOTE': '1', 05:52:53 INFO - 'NO_EM_RESTART': '1', 05:52:53 INFO - 'PAGER': '/bin/cat', 05:52:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:52:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:53 INFO - 'PWD': '/builds/slave/test', 05:52:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:52:53 INFO - 'SHELL': '/bin/bash', 05:52:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ij8uOpdQv5/Listeners', 05:52:53 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 05:52:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:52:53 INFO - 'USER': 'cltbld', 05:52:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:52:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:52:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:53 INFO - 'XPC_FLAGS': '0x0', 05:52:53 INFO - 'XPC_SERVICE_NAME': '0', 05:52:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:52:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:53 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:52:53 INFO - Cleaning up... 05:52:54 INFO - Return code: 0 05:52:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:52: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:52:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52: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:52:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:54 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 0x10fa66490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f9dc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ec1cd4640>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f87ad30>, '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 0x10f6e0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f872b20>, '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.eMKAMV9gzh/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.ij8uOpdQv5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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:52:54 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:52:54 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:52:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eMKAMV9gzh/Render', 05:52:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:52:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:52:54 INFO - 'HOME': '/Users/cltbld', 05:52:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:52:54 INFO - 'LOGNAME': 'cltbld', 05:52:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:54 INFO - 'MOZ_NO_REMOTE': '1', 05:52:54 INFO - 'NO_EM_RESTART': '1', 05:52:54 INFO - 'PAGER': '/bin/cat', 05:52:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:52:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:54 INFO - 'PWD': '/builds/slave/test', 05:52:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:52:54 INFO - 'SHELL': '/bin/bash', 05:52:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ij8uOpdQv5/Listeners', 05:52:54 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 05:52:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:52:54 INFO - 'USER': 'cltbld', 05:52:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:52:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:52:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:54 INFO - 'XPC_FLAGS': '0x0', 05:52:54 INFO - 'XPC_SERVICE_NAME': '0', 05:52:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:52:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:54 INFO - Downloading/unpacking psutil>=3.1.1 05:52:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:52:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:52:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:52:56 INFO - Installing collected packages: psutil 05:52:56 INFO - Running setup.py install for psutil 05:52:57 INFO - building 'psutil._psutil_osx' extension 05:52:57 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:52:57 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:52:57 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:52:57 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:52:57 INFO - building 'psutil._psutil_posix' extension 05:52:57 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:52:57 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:52:57 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:52:57 INFO - ^ 05:52:57 INFO - 1 warning generated. 05:52:57 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:52:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:52:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:52:57 INFO - Successfully installed psutil 05:52:57 INFO - Cleaning up... 05:52:57 INFO - Return code: 0 05:52:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:52:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fa66490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f9dc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ec1cd4640>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f87ad30>, '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 0x10f6e0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f872b20>, '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.eMKAMV9gzh/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.ij8uOpdQv5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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:52:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:52:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:52:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eMKAMV9gzh/Render', 05:52:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:52:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:52:57 INFO - 'HOME': '/Users/cltbld', 05:52:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:52:57 INFO - 'LOGNAME': 'cltbld', 05:52:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:57 INFO - 'MOZ_NO_REMOTE': '1', 05:52:57 INFO - 'NO_EM_RESTART': '1', 05:52:57 INFO - 'PAGER': '/bin/cat', 05:52:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:52:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:57 INFO - 'PWD': '/builds/slave/test', 05:52:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:52:57 INFO - 'SHELL': '/bin/bash', 05:52:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ij8uOpdQv5/Listeners', 05:52:57 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 05:52:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:52:57 INFO - 'USER': 'cltbld', 05:52:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:52:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:52:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:57 INFO - 'XPC_FLAGS': '0x0', 05:52:57 INFO - 'XPC_SERVICE_NAME': '0', 05:52:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:52:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:52:58 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:52:58 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:52:58 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:52:58 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:52:58 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:52:58 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:53:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:53:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:53:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:53:00 INFO - Installing collected packages: mozsystemmonitor 05:53:00 INFO - Running setup.py install for mozsystemmonitor 05:53:00 INFO - Successfully installed mozsystemmonitor 05:53:00 INFO - Cleaning up... 05:53:00 INFO - Return code: 0 05:53:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:53: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:53:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53: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:53:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53: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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fa66490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f9dc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ec1cd4640>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f87ad30>, '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 0x10f6e0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f872b20>, '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.eMKAMV9gzh/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.ij8uOpdQv5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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:53: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==2.5.1'] in /builds/slave/test/build 05:53: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==2.5.1 05:53:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eMKAMV9gzh/Render', 05:53:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:53:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:53:00 INFO - 'HOME': '/Users/cltbld', 05:53:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:53:00 INFO - 'LOGNAME': 'cltbld', 05:53:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:00 INFO - 'MOZ_NO_REMOTE': '1', 05:53:00 INFO - 'NO_EM_RESTART': '1', 05:53:00 INFO - 'PAGER': '/bin/cat', 05:53:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:53:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:00 INFO - 'PWD': '/builds/slave/test', 05:53:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:53:00 INFO - 'SHELL': '/bin/bash', 05:53:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ij8uOpdQv5/Listeners', 05:53:00 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 05:53:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:53:00 INFO - 'USER': 'cltbld', 05:53:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:53:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:53:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:00 INFO - 'XPC_FLAGS': '0x0', 05:53:00 INFO - 'XPC_SERVICE_NAME': '0', 05:53:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:53:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:01 INFO - Downloading/unpacking jsonschema==2.5.1 05:53:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:53:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:53:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:04 INFO - Downloading functools32-3.2.3-2.tar.gz 05:53:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:53:04 INFO - warning: no files found matching '*.txt' 05:53:04 INFO - no previously-included directories found matching 'build' 05:53:04 INFO - no previously-included directories found matching 'dist' 05:53:04 INFO - no previously-included directories found matching '.git*' 05:53:04 INFO - Installing collected packages: jsonschema, functools32 05:53:04 INFO - Running setup.py install for functools32 05:53:04 INFO - warning: no files found matching '*.txt' 05:53:04 INFO - no previously-included directories found matching 'build' 05:53:04 INFO - no previously-included directories found matching 'dist' 05:53:04 INFO - no previously-included directories found matching '.git*' 05:53:04 INFO - Successfully installed jsonschema functools32 05:53:04 INFO - Cleaning up... 05:53:04 INFO - Return code: 0 05:53:04 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:53:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10fa66490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f9dc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ec1cd4640>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f87ad30>, '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 0x10f6e0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f872b20>, '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.eMKAMV9gzh/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.ij8uOpdQv5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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:53:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:53:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 05:53:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eMKAMV9gzh/Render', 05:53:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:53:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:53:04 INFO - 'HOME': '/Users/cltbld', 05:53:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:53:04 INFO - 'LOGNAME': 'cltbld', 05:53:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:04 INFO - 'MOZ_NO_REMOTE': '1', 05:53:04 INFO - 'NO_EM_RESTART': '1', 05:53:04 INFO - 'PAGER': '/bin/cat', 05:53:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:53:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:04 INFO - 'PWD': '/builds/slave/test', 05:53:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:53:04 INFO - 'SHELL': '/bin/bash', 05:53:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ij8uOpdQv5/Listeners', 05:53:04 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 05:53:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:53:04 INFO - 'USER': 'cltbld', 05:53:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:53:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:53:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:04 INFO - 'XPC_FLAGS': '0x0', 05:53:04 INFO - 'XPC_SERVICE_NAME': '0', 05:53:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:53:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:04 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:53:04 INFO - Cleaning up... 05:53:04 INFO - Return code: 0 05:53:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:53:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10fa66490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f9dc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ec1cd4640>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f87ad30>, '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 0x10f6e0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f872b20>, '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.eMKAMV9gzh/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.ij8uOpdQv5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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:53:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:53:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:53:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eMKAMV9gzh/Render', 05:53:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:53:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:53:04 INFO - 'HOME': '/Users/cltbld', 05:53:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:53:04 INFO - 'LOGNAME': 'cltbld', 05:53:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:04 INFO - 'MOZ_NO_REMOTE': '1', 05:53:04 INFO - 'NO_EM_RESTART': '1', 05:53:04 INFO - 'PAGER': '/bin/cat', 05:53:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:53:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:04 INFO - 'PWD': '/builds/slave/test', 05:53:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:53:04 INFO - 'SHELL': '/bin/bash', 05:53:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ij8uOpdQv5/Listeners', 05:53:04 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 05:53:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:53:04 INFO - 'USER': 'cltbld', 05:53:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:53:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:53:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:04 INFO - 'XPC_FLAGS': '0x0', 05:53:04 INFO - 'XPC_SERVICE_NAME': '0', 05:53:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:53:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:05 INFO - Downloading/unpacking blobuploader==1.2.4 05:53:05 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:53:05 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:53:05 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:53:05 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:53:05 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:53:05 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:53:07 INFO - Downloading blobuploader-1.2.4.tar.gz 05:53:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:53:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:53:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:53:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:53:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:08 INFO - Downloading docopt-0.6.1.tar.gz 05:53:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:53:08 INFO - Installing collected packages: blobuploader, requests, docopt 05:53:08 INFO - Running setup.py install for blobuploader 05:53:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:53:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:53:08 INFO - Running setup.py install for requests 05:53:09 INFO - Running setup.py install for docopt 05:53:09 INFO - Successfully installed blobuploader requests docopt 05:53:09 INFO - Cleaning up... 05:53:09 INFO - Return code: 0 05:53:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:53:09 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:53:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:09 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:53:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:09 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 0x10fa66490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f9dc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ec1cd4640>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f87ad30>, '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 0x10f6e0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f872b20>, '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.eMKAMV9gzh/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.ij8uOpdQv5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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:53:09 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:53:09 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:53:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eMKAMV9gzh/Render', 05:53:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:53:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:53:09 INFO - 'HOME': '/Users/cltbld', 05:53:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:53:09 INFO - 'LOGNAME': 'cltbld', 05:53:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:09 INFO - 'MOZ_NO_REMOTE': '1', 05:53:09 INFO - 'NO_EM_RESTART': '1', 05:53:09 INFO - 'PAGER': '/bin/cat', 05:53:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:53:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:09 INFO - 'PWD': '/builds/slave/test', 05:53:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:53:09 INFO - 'SHELL': '/bin/bash', 05:53:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ij8uOpdQv5/Listeners', 05:53:09 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 05:53:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:53:09 INFO - 'USER': 'cltbld', 05:53:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:53:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:53:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:09 INFO - 'XPC_FLAGS': '0x0', 05:53:09 INFO - 'XPC_SERVICE_NAME': '0', 05:53:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:53:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:53:09 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-I_Mn_a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:53:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:53:10 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-BrlFoN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:53:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:53:10 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-rWkzAM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:53:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:53:10 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-jYH7d9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:53:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:53:10 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-SB5pfR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:53:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:53:10 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-OcP8Dd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:53:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:53:10 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-gAgv3E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:53:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:53:10 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-AGq4n1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:53:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:53:10 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-USpyFe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:53:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:53:10 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-fYVred-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:53:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:53:11 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-8HKTYK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:53:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:53:11 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-KXQiqb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:53:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:53:11 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-4lCDAF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:53:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:53:11 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-Ws2PM0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:53:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:53:11 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-BDRWVz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:53:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:53:11 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-h3evS2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:53:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:53:11 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-NYBHUj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:53:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:53:11 INFO - Running setup.py install for manifestparser 05:53:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:53:11 INFO - Running setup.py install for mozcrash 05:53:12 INFO - Running setup.py install for mozdebug 05:53:12 INFO - Running setup.py install for mozdevice 05:53:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:53:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:53:12 INFO - Running setup.py install for mozfile 05:53:12 INFO - Running setup.py install for mozhttpd 05:53:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:53:12 INFO - Running setup.py install for mozinfo 05:53:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:53:12 INFO - Running setup.py install for mozInstall 05:53:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:53:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:53:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:53:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:53:12 INFO - Running setup.py install for mozleak 05:53:13 INFO - Running setup.py install for mozlog 05:53:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:53:13 INFO - Running setup.py install for moznetwork 05:53:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:53:13 INFO - Running setup.py install for mozprocess 05:53:13 INFO - Running setup.py install for mozprofile 05:53:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:53:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:53:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:53:13 INFO - Running setup.py install for mozrunner 05:53:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:53:13 INFO - Running setup.py install for mozscreenshot 05:53:14 INFO - Running setup.py install for moztest 05:53:14 INFO - Running setup.py install for mozversion 05:53:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:53:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:53:14 INFO - Cleaning up... 05:53:14 INFO - Return code: 0 05:53:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:53:14 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:53:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:14 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:53:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:14 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 0x10fa66490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f9dc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ec1cd4640>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f87ad30>, '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 0x10f6e0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f872b20>, '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.eMKAMV9gzh/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.ij8uOpdQv5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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:53:14 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:53:14 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:53:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eMKAMV9gzh/Render', 05:53:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:53:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:53:14 INFO - 'HOME': '/Users/cltbld', 05:53:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:53:14 INFO - 'LOGNAME': 'cltbld', 05:53:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:14 INFO - 'MOZ_NO_REMOTE': '1', 05:53:14 INFO - 'NO_EM_RESTART': '1', 05:53:14 INFO - 'PAGER': '/bin/cat', 05:53:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:53:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:14 INFO - 'PWD': '/builds/slave/test', 05:53:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:53:14 INFO - 'SHELL': '/bin/bash', 05:53:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ij8uOpdQv5/Listeners', 05:53:14 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 05:53:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:53:14 INFO - 'USER': 'cltbld', 05:53:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:53:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:53:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:14 INFO - 'XPC_FLAGS': '0x0', 05:53:14 INFO - 'XPC_SERVICE_NAME': '0', 05:53:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:53:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:53:14 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-LzvnZC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:53:14 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:53:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:53:14 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-GAsS0a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:53:14 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:53:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:53:14 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-bYQiPZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:53:14 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:53:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:53:14 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-WqQgum-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:53:15 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:53:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:53:15 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-ufSDcj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:53:15 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:53:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:53:15 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-wyEwC4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:53:15 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:53:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:53:15 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-Si3mzN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:53:15 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:53:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:53:15 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-Ov_7Wo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:53:15 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:53:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:53:15 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-j8sz0K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:53:15 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:53:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:53:15 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-rEJgqz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:53:15 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:53:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:53:15 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-JMjZBy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:53:15 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:53:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:53:15 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-_rYDz2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:53:15 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:53:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:53:15 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-XDVVmC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:53:16 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:53:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:53:16 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-QVyTsD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:53:16 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:53:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:53:16 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-MdkIb4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:53:16 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:53:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:53:16 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-hajl39-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:53:16 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:53:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:53:16 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-6609oy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:53:16 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:53:16 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:53:16 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:53:16 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:53:16 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:53:16 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:53:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:53:16 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:53:16 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:53:16 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:53:16 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:53:16 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:53:16 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:53:18 INFO - Downloading blessings-1.6.tar.gz 05:53:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:53:19 INFO - Installing collected packages: blessings 05:53:19 INFO - Running setup.py install for blessings 05:53:19 INFO - Successfully installed blessings 05:53:19 INFO - Cleaning up... 05:53:19 INFO - Return code: 0 05:53:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:53:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:53:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:53:19 INFO - Reading from file tmpfile_stdout 05:53:19 INFO - Current package versions: 05:53:19 INFO - blessings == 1.6 05:53:19 INFO - blobuploader == 1.2.4 05:53:19 INFO - docopt == 0.6.1 05:53:19 INFO - functools32 == 3.2.3-2 05:53:19 INFO - jsonschema == 2.5.1 05:53:19 INFO - manifestparser == 1.1 05:53:19 INFO - mozInstall == 1.12 05:53:19 INFO - mozcrash == 0.17 05:53:19 INFO - mozdebug == 0.1 05:53:19 INFO - mozdevice == 0.48 05:53:19 INFO - mozfile == 1.2 05:53:19 INFO - mozhttpd == 0.7 05:53:19 INFO - mozinfo == 0.9 05:53:19 INFO - mozleak == 0.1 05:53:19 INFO - mozlog == 3.4 05:53:19 INFO - moznetwork == 0.27 05:53:19 INFO - mozprocess == 0.23 05:53:19 INFO - mozprofile == 0.28 05:53:19 INFO - mozrunner == 6.12 05:53:19 INFO - mozscreenshot == 0.1 05:53:19 INFO - mozsystemmonitor == 0.3 05:53:19 INFO - moztest == 0.7 05:53:19 INFO - mozversion == 1.4 05:53:19 INFO - psutil == 3.1.1 05:53:19 INFO - requests == 1.2.3 05:53:19 INFO - wsgiref == 0.1.2 05:53:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:53:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:19 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 0x10fa66490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f9dc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ec1cd4640>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f87ad30>, '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 0x10f6e0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f872b20>, '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.eMKAMV9gzh/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.ij8uOpdQv5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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:53:19 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:53:19 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:53:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eMKAMV9gzh/Render', 05:53:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:53:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:53:19 INFO - 'HOME': '/Users/cltbld', 05:53:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:53:19 INFO - 'LOGNAME': 'cltbld', 05:53:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:19 INFO - 'MOZ_NO_REMOTE': '1', 05:53:19 INFO - 'NO_EM_RESTART': '1', 05:53:19 INFO - 'PAGER': '/bin/cat', 05:53:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:53:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:19 INFO - 'PWD': '/builds/slave/test', 05:53:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:53:19 INFO - 'SHELL': '/bin/bash', 05:53:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ij8uOpdQv5/Listeners', 05:53:19 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 05:53:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:53:19 INFO - 'USER': 'cltbld', 05:53:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:53:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:53:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:19 INFO - 'XPC_FLAGS': '0x0', 05:53:19 INFO - 'XPC_SERVICE_NAME': '0', 05:53:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:53:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:19 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:53:19 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:53:19 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:53:19 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:53:19 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:53:19 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:53:19 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:53:19 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:53:19 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:53:19 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:53:19 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:53:19 INFO - Cleaning up... 05:53:19 INFO - Return code: 0 05:53:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:53:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:19 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 0x10fa66490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f9dc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ec1cd4640>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f87ad30>, '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 0x10f6e0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f872b20>, '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.eMKAMV9gzh/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.ij8uOpdQv5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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:53:19 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:53:19 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:53:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eMKAMV9gzh/Render', 05:53:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:53:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:53:19 INFO - 'HOME': '/Users/cltbld', 05:53:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:53:19 INFO - 'LOGNAME': 'cltbld', 05:53:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:19 INFO - 'MOZ_NO_REMOTE': '1', 05:53:19 INFO - 'NO_EM_RESTART': '1', 05:53:19 INFO - 'PAGER': '/bin/cat', 05:53:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:53:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:19 INFO - 'PWD': '/builds/slave/test', 05:53:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:53:19 INFO - 'SHELL': '/bin/bash', 05:53:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ij8uOpdQv5/Listeners', 05:53:19 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 05:53:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:53:19 INFO - 'USER': 'cltbld', 05:53:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:53:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:53:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:19 INFO - 'XPC_FLAGS': '0x0', 05:53:19 INFO - 'XPC_SERVICE_NAME': '0', 05:53:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:53:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:20 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:53:20 INFO - Cleaning up... 05:53:20 INFO - Return code: 0 05:53:20 INFO - Running post-action listener: _resource_record_post_action 05:53:20 INFO - Running post-action listener: _start_resource_monitoring 05:53:20 INFO - Starting resource monitoring. 05:53:20 INFO - [mozharness: 2016-11-04 12:53:20.101220Z] Finished create-virtualenv step (success) 05:53:20 INFO - [mozharness: 2016-11-04 12:53:20.102219Z] Running install step. 05:53:20 INFO - Running pre-action listener: _resource_record_pre_action 05:53:20 INFO - Running main action method: install 05:53:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:53:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:53:20 INFO - Reading from file tmpfile_stdout 05:53:20 INFO - Detecting whether we're running mozinstall >=1.0... 05:53:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:53:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:53:20 INFO - Reading from file tmpfile_stdout 05:53:20 INFO - Output received: 05:53:20 INFO - Usage: mozinstall [options] installer 05:53:20 INFO - Options: 05:53:20 INFO - -h, --help show this help message and exit 05:53:20 INFO - -d DEST, --destination=DEST 05:53:20 INFO - Directory to install application into. [default: 05:53:20 INFO - "/builds/slave/test"] 05:53:20 INFO - --app=APP Application being installed. [default: firefox] 05:53:20 INFO - mkdir: /builds/slave/test/build/application 05:53:20 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:53:20 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:53:52 INFO - Reading from file tmpfile_stdout 05:53:52 INFO - Output received: 05:53:52 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 05:53:52 INFO - Running post-action listener: _resource_record_post_action 05:53:52 INFO - [mozharness: 2016-11-04 12:53:52.619558Z] Finished install step (success) 05:53:52 INFO - [mozharness: 2016-11-04 12:53:52.619687Z] Running run-tests step. 05:53:52 INFO - Running pre-action listener: _resource_record_pre_action 05:53:52 INFO - Running main action method: run_tests 05:53:52 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:53:52 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:53:52 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:53:52 INFO - 2016-11-04 05:53:52.634 screenresolution[29400:273144] starting screenresolution argv=screenresolution get 05:53:52 INFO - 2016-11-04 05:53:52.636 screenresolution[29400:273144] Display 0: 1600x1200x32@60 05:53:52 INFO - 2016-11-04 05:53:52.642 screenresolution[29401:273146] starting screenresolution argv=screenresolution list 05:53:52 INFO - Available Modes on Display 0 05:53:52 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:53:52 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:53:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:53:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:53:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:53:52 INFO - Intel Iris: 05:53:52 INFO - Chipset Model: Intel Iris 05:53:52 INFO - Type: GPU 05:53:52 INFO - Bus: Built-In 05:53:52 INFO - VRAM (Dynamic, Max): 1536 MB 05:53:52 INFO - Vendor: Intel (0x8086) 05:53:52 INFO - Device ID: 0x0a2e 05:53:52 INFO - Revision ID: 0x0009 05:53:52 INFO - Displays: 05:53:52 INFO - Display: 05:53:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:53:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:53:52 INFO - Display Serial Number: 1600x1200 60 05:53:52 INFO - Main Display: Yes 05:53:52 INFO - Mirror: Off 05:53:52 INFO - Online: Yes 05:53:52 INFO - Rotation: Supported 05:53:52 INFO - Return code: 0 05:53:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:53:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:53:52 INFO - Python 2.7.3 05:53:52 INFO - Return code: 0 05:53:52 INFO - grabbing minidump binary from tooltool 05:53:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:52 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 0x10f87ad30>, '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 0x10f6e0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f872b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:53:52 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:53:52 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:53:52 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:53:52 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:53:53 INFO - Return code: 0 05:53:53 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:53:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:53:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:53:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:53:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:53:53 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-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bem3mmm3QYCTLOOtaNv64g/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0163', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 05:53:53 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-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bem3mmm3QYCTLOOtaNv64g/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0163 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:53:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eMKAMV9gzh/Render', 05:53:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:53:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:53:53 INFO - 'HOME': '/Users/cltbld', 05:53:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:53:53 INFO - 'LOGNAME': 'cltbld', 05:53:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:53:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:53:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:53 INFO - 'MOZ_NO_REMOTE': '1', 05:53:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:53:53 INFO - 'NO_EM_RESTART': '1', 05:53:53 INFO - 'PAGER': '/bin/cat', 05:53:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:53:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:53 INFO - 'PWD': '/builds/slave/test', 05:53:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:53:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:53:53 INFO - 'SHELL': '/bin/bash', 05:53:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ij8uOpdQv5/Listeners', 05:53:53 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 05:53:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:53:53 INFO - 'USER': 'cltbld', 05:53:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:53:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:53:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:53 INFO - 'XPC_FLAGS': '0x0', 05:53:53 INFO - 'XPC_SERVICE_NAME': '0', 05:53:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:53:53 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bem3mmm3QYCTLOOtaNv64g/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0163', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:53:53 INFO - mozversion application_buildid: 20161104032020 05:53:53 INFO - mozversion application_changeset: 1a8ed7ba82adecdd095ae3d7d99bcf672ef7e976 05:53:53 INFO - mozversion application_display_name: FirefoxDeveloperEdition 05:53:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:53:53 INFO - mozversion application_name: Firefox 05:53:53 INFO - mozversion application_remotingname: firefox-dev 05:53:53 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:53:53 INFO - mozversion application_vendor: Mozilla 05:53:53 INFO - mozversion application_version: 51.0a2 05:53:53 INFO - mozversion platform_buildid: 20161104032020 05:53:53 INFO - mozversion platform_changeset: 1a8ed7ba82adecdd095ae3d7d99bcf672ef7e976 05:53:53 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:53:53 INFO - mozversion platform_version: 51.0a2 05:53:53 INFO - using testdate: 1478264033 05:53:53 INFO - actual date: 1478264033 05:53:53 INFO - starting webserver on 'localhost:52330' 05:53:53 INFO - SUITE-START | Running 2 tests 05:53:53 INFO - TEST-START | dromaeo_css 05:53:53 INFO - operating with platform_type : mac_ 05:53:53 INFO - Initialising browser for dromaeo_css test... 05:53:53 INFO - TEST-INFO | started process 29411 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/tmpIx7xND/profile http://localhost:52330/getInfo.html) 05:53:55 INFO - PROCESS | 29411 | __metrics Screen width/height:1600/1200 05:53:55 INFO - PROCESS | 29411 | colorDepth:24 05:53:55 INFO - PROCESS | 29411 | Browser inner width/height: 1024/689 05:53:55 INFO - PROCESS | 29411 | __metrics 05:53:56 ERROR - PROCESS | 29411 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 05:53:56 INFO - TEST-INFO | 29411: exit 0 05:53:56 INFO - Browser initialized. 05:53:56 INFO - Running cycle 1/1 for dromaeo_css test... 05:53:56 INFO - TEST-INFO | started process 29414 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/tmpIx7xND/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:54:08 INFO - PROCESS | 29414 | RSS: Main: 225136640 05:54:08 INFO - PROCESS | 29414 | 05:54:58 INFO - PROCESS | 29414 | 1478264098540 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:57:10 INFO - PROCESS | 29414 | Cycle 1(1): loaded http://localhost:52330/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52330/tests/dromaeo/cssquery-ext.html) 05:57:12 INFO - PROCESS | 29414 | RSS: Main: 239837184 05:57:12 INFO - PROCESS | 29414 | 06:00:14 INFO - PROCESS | 29414 | Cycle 1(1): loaded http://localhost:52330/tests/dromaeo/cssquery-ext.html (next: http://localhost:52330/tests/dromaeo/cssquery-jquery.html) 06:00:15 INFO - PROCESS | 29414 | RSS: Main: 250302464 06:00:15 INFO - PROCESS | 29414 | 06:03:16 INFO - PROCESS | 29414 | Cycle 1(1): loaded http://localhost:52330/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52330/tests/dromaeo/cssquery-mootools.html) 06:03:17 INFO - PROCESS | 29414 | RSS: Main: 252624896 06:03:17 INFO - PROCESS | 29414 | 06:06:19 INFO - PROCESS | 29414 | Cycle 1(1): loaded http://localhost:52330/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52330/tests/dromaeo/cssquery-prototype.html) 06:06:19 INFO - PROCESS | 29414 | RSS: Main: 252653568 06:06:19 INFO - PROCESS | 29414 | 06:09:22 INFO - PROCESS | 29414 | Cycle 1(1): loaded http://localhost:52330/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52330/tests/dromaeo/cssquery-yui.html) 06:09:23 INFO - PROCESS | 29414 | RSS: Main: 257363968 06:09:23 INFO - PROCESS | 29414 | 06:12:25 INFO - PROCESS | 29414 | Cycle 1(1): loaded http://localhost:52330/tests/dromaeo/cssquery-yui.html (next: http://localhost:52330/tests/dromaeo/cssquery-dojo.html) 06:12:26 INFO - PROCESS | 29414 | RSS: Main: 259883008 06:12:26 INFO - PROCESS | 29414 | 06:12:26 INFO - PROCESS | 29414 | __start_tp_report 06:12:26 INFO - PROCESS | 29414 | _x_x_mozilla_page_load 06:12:26 INFO - PROCESS | 29414 | _x_x_mozilla_page_load_details 06:12:26 INFO - PROCESS | 29414 | |i|pagename|runs| 06:12:26 INFO - PROCESS | 29414 | |0;dojo.html;3343.582052243468;3371.140359208402;3378.9863041087674;3381.2561236527954;3397.830108494576;5728.57035722321;5743.597948143632;5779.50874175695;5825.796097136601;5827.213326200962;4506.549345065492;5818.2145410369585;5834.912476312858;5844.444777746118;5871.266091738533;4309.784510774449;4471.374007638933;5255.264263003182;5330.973345133289;5351.57187425005;4666.953330466686;5334.759935802898;5351.063563876325;5393.78424863007;5397.217403476494;5232.8691782705355;5256.237845512398;5339.385970613371;5346;5363.490468405515;5246;5308.5487733542695;5324.680519168863;5336.653117547347;5387.1111266640955;4485.416895803524;5145.536901678829;5277.920831187535;5280.2343660169445;5283.181106928432;4852.4662287148385;5655.26481557399;5783.21926539916;5904.1734157218025;5919.408059194089;5943.64338139713;6135.508280839769;6162.506999440034;6246.781362652286;6285.528585356116;5696.3733989261145;6289.40250676185;6340.397662222082;6358.395952384516;6373.075903993941;5879.559033072451;5888.411158884077;5894.616849904743;5901.616394934315;5910.704464776744;6257;6265.966115590876;6268.968655156695;6289.276733175743;6323.715432805535;6203.069539569101;6229.875402491924;6247.187865577446;6257.217847769029;6268.153799237045;6252.624842509464;6308.589941653778;6350.555461117678;6352.618842869442;6356.300806911236;6145.555794388315;6188.319284878659;6212.099245609452;6242.937570624235;6306.054091886162;6241.656708881055;6298.685065746694;6307.905381419282;6335.11308416822;6338.429541341301;4960.950390496048;4971.701697898137;4972.72650004246;4982.6512144149565;4999.425066117443;4329.350597410414;4385.583369579948;4421.845235416745;4461.843835465743;4465.910681786411;5798.971005144947;5918;5953.553483488756;6011.3086994995265;6061.454469097803;6277.686115694197;6309.432151106423;6311.958526843019;6328.525360597973;6359.618422894641;5345.705986170798;5746.13807928814;5855.180274761537;6000.279966403972;6038.094285857069;4410.558944105564;5482.2873026506295;5483.862903427366;5487.75305111271;5515;6356.682165891687;6380.840478988062;6381.617102973836;6389.361063893573;6391.840203994844;6131.315499378873;6183.5671502994355;6220.066989951543;6257.968710156602;6288.11966324724;6410.871782564416;6418.614883107029;6432.3246059164985;6435.195600549931;6439.774607888889;6232.283287421823;6238.625682458885;6246.094316324198;6251.124842521959;6269.937300626935;6169.105479705508;6229.937700623117;6235.282942461494;6285.49716022708;6309.432151106423;5983.4914032306;6136.21274067861;6142.3759981611065;6176.382361763967;6200.3489633589625;6196.845078872884;6202.069689546604;6204.441600255998;6210.161628180319;6221.129041934042;4443.377927090274;5937.851553711192;6020.277566692025;6106.877862442815;6167.198264225622;6100.359462256399;6113.205283313141;6119.197913140417;6126.693665316628;6191.907121393093;6023.849403764941;6028.125921741411;6031.69841507914;6051.213342265477;6059.303180134341 06:12:26 INFO - PROCESS | 29414 | |1;ext.html;385.8263781298416;420.28761249681804;431.8035293941257;432.1335721877635;499.26109358149915;39604.20791584167;41927.371089433684;42004.369934450966;42008.36987445187;42012.36981445281;34283.142921426974;38854.22291554167;41046.384304235464;43062.138757224835;43444;9885.060919212681;10029.097381235688;10036.59853605855;10081.647142350019;10121.645742399018;8898.28813694906;9955.651552195675;10079.596816127383;10090.899091009069;10157.441340726256;10080.69757907264;10097.798044039151;10136.49317534124;10138.594456221743;10153.593856245741;10043.99560043997;10079;10101.646442374555;10110.090091891692;10144.797104057914;9826.557804898797;9905.90094099057;9926.45404502752;9948.154406875425;9962.651307204213;40212.195756085006;40388.394174087414;40418.79790601058;40461.79769101165;40630.79684601558;3443.2596991646915;3524.7708898921487;3639.4540818877117;3867.0139114525896;4038.7980600970127;23912.641310380186;30564.694353056406;32182.356352872812;32441.675583244338;32619.67380326214;3245.789023713451;3282.0810173151553;3296.76922615417;3361.596608407007;3383.5770528683915;537233;537269.3136534331;541334;542872;544087.2795636036;33195.66804331974;34547.79082732143;62306;62505.374946249955;62888;34973.65026349704;35298.64701353005;35339.4699079514;35405.114872128404;35589;15417.074975501506;15470.613234669223;15481.303341349667;15541.611459713598;15592.220388980506;12711.300878451773;13101.41043653038;13198.934005329911;13211.603651890458;13234.536791212262;7806.219378062262;7821.648025838851;7827.726029588937;7882.09355924076;7892.921070789219;3262.4780035194253;3287.6054873414864;3291.0253847691674;3291.358185153872;3312.569365982407;853.8420392227333;913.853783394667;914.2183433164681;926.9165775080276;1027.6505987964129;30174.84912575467;30462.086137415914;30892.382152357277;31081;31369;938.7136923238342;984.6898227058454;1133.7732453509332;1142.4687520303098;1144.5789123020018;15014.699706005818;15703;15738.134402607737;15779.132147731985;15946.20268986546;1011557;1028969;1032725;1034465;1038641;58835.411645882996;59434;59529.40470595325;59644.40355596475;59743.70128149331;1247.7691627049026;1349.6153596225029;1375.40170026039;1398.489551313763;1400.8319001719858;29121.563176551947;31417.68582314239;31583.052508424786;31598.842005789826;32044.5193322105;51374.486255138465;51499.48500514947;51911.74044129755;51945;51980.22029669634;661000;664763;664821;664899;666188;21751.673724893823;22513.549729005656;26344.209673709818;26747.732522674523;27884.58173127445;46506;47281.77376032067;47723.761381192875;47881;47981.04037919292;37409.43885841769;39160.41259381054;39458.40812387759;40154.799226003684;40375.59624403718;38935.41596876106;39116.2176756469;39815.601843982346;40461.79769101136;40469.59530404776;38199.42700859545;38519.80740096282;39199.80400097981;39213.01967450837;40427.98930026773;24957.251282461555;28664.136831105912;30093.09720708382;32461.837690811393;35057.47413788744;21647;23457.882710587022;25636;26134.607980880683;26192.73807261903 06:12:26 INFO - PROCESS | 29414 | |2;jquery.html;365.1765269317688;371.58939371993955;378.5306220286845;382.45882076861244;398.12015445864654;19239.903800480995;20358.491037724063;20832.958352082373;20852.478688032807;20958.056887440063;17724.1137943103;18716.251349945986;20051.498712532193;20509.871957042356;20928.058237379315;3971.6226958439047;5241;5772.451617096369;5942.554308426864;6018.51851851853;5895.911561326584;5976.043832986723;6017.789377371793;6025.9096113558335;6027.72875220614;5703.230063941377;5781.277340332458;5802.5938184327115;5940.61386009908;5991.610545314541;4699.741514216734;4724.4094488188975;5301.602379821509;5887.322957859816;5905.970470147665;4875.317455556225;4996.075725990703;5087.79648814047;5145.742712864379;5158.045761534091;19335.80664193354;24620.753792462026;25727.61408578873;25911.481770364677;26052.088176913716;2221.766714494971;2237.8209743220505;2283.3264187064856;2482.1808803095114;3074.3851229754137;11916.523339066427;14957.027793193516;15369.46206882765;15437.459688910947;15710.764338534931;1858.1916866163263;1874.6344462829754;1891.877027993176;1894.355918987551;1934.2843148035176;102908.48545757373;109628.451857741;116228;116622.41688791587;116791;8530.360222983301;10648.680539583826;10716.089132423675;10984.945075274572;11085.168612354106;13547.254900980344;13572.1856688599;13592.592222233348;13600.86399135996;13620.523281685093;8528.104549022264;8697.95651021741;8789.912100879037;8884.244839188612;8929.553522323988;8827.426217295855;8886.688965886164;8921.776955576162;9031.548422578844;9061.093890611019;6478.4169424752;6625.734970601122;6656.068150458939;6673.232578253466;6683.331666833278;1576.5979675182755;1846.538365408648;1856.851451883846;1870.9532261693566;1895.8672892897641;985.5909797434128;987.0604262623979;1021.4637315409469;1021.867157269565;1052.2371280821496;21219.68170477444;21780.78219217819;21861.234856779938;22021.00905459226;22030.669539956914;938.7277689470113;939.6006697153819;974.133021610767;1021.9029192226726;1028.6502589119586;9580.233581313478;11397.829032564518;11489.540418383338;11547.653570392902;11695.76608467843;520238;612284;614435;626138;627888;92421.15157696808;105810;107811.46094269636;117115;118752.40623796826;926.333040211047;1004.492731170754;1006.6979906028163;1065.1478816946567;1070.0476575847501;18301.816981830012;18789.34237301688;18936.810631894055;19158.946257955948;19310.034498275312;40222.1955560893;48967.51032489772;54278;57164.99922502693;57412.85174296407;75194.87207691779;75658.6217068911;77317.06707332362;77684.61157694175;77840.83238751536;7161.4986950912935;7983.481073730189;8004.879926801219;8120.75637730869;8408.663653453794;9051.366404351633;10742.603461549948;12080.45637946277;12385.690357740768;12910.870891290966;8271.255586997198;9703.708888733348;11069.00378965897;11342.546298148312;11738.119641027128;10171.338862973884;10438.851726309947;11367.317960922372;11431.885681143081;11615;10058.698239052841;11091.667249982513;11483.885161148615;11487.19589628718;11625.76748465009;7771.37828973692;7983.20167983197;8324.217841286516;8378.329733621174;8380.832383352177;8194.426390152632;11125.332480051224;11380.089592832719;11531.481083351437;11685.948264656221 06:12:26 INFO - PROCESS | 29414 | |3;mootools.html;1423;1463.4731496661204;1639.401618409281;1772.3885259585438;1800.954976125596;8078.838423231532;8353.415260931737;8565.800787889693;9174.128457796507;9195;8565.443246188994;8916.108389161082;8923;9009.00900900902;9017;2368.3723813189517;2410.819188560856;2412.3124909400826;2422.600270955299;2430.586800243954;2019.3538067818304;2065.535254567718;2395.341281147681;2416.1060407649106;2417.8791060446906;2405.8075353971726;2413.625887987365;2421.6730741349957;2432.8905199265987;2437.0982736387473;2371.4901296221396;2390.306811024801;2397.7722116398913;2406.350285422926;2411.782939535433;2381.8570885746913;2403.6755038069987;2405.230326295586;2405.4707964247837;2414.7343792182846;8960.596773145158;9024.368294219406;9072.09279072094;9093.863592046124;9106.681266155652;5157.355330583677;5315.654482458628;5317.0163519748585;5319.468053194688;5325.094733895247;3667.6699097081123;3708;3737.813109344549;3741.850325986957;3749.643783840531;1100.1583788401879;1104.3484344236938;1104.6741211342674;1116.7878103160374;1128.8814674459227;11696.415179241005;11833.290002599872;11939.044876409866;11954.940225298818;11962.88037119635;4153.979230103831;4726.574608285271;4744.5492678195515;4751.783145896422;4912.164931961575;9932.404055756677;10015.098641122187;10027.749306267402;10034.899651003396;10037.99620038005;5388.003219404422;5396.649217800909;5404.8108316208745;5408.269883565747;5428.430014848384;4448.733076015449;4600.148972440043;4806.735629540409;4930.8767280818265;4950.2079667253065;3962.8018599069933;3993.66053885423;4070.287699652549;4096.160287141129;4103.343465045638;1317.0846261847923;1326.9867301326863;1330.301591664384;1333.3000174908057;1346.5556366399064;790.9914858555388;798.2815466080574;891.3047822698305;896.8968568614692;946.7301818981557;5540.750666220029;5746.744057874562;5764.164196191528;5836.737346819404;5923.911141332884;727.4689476681946;1024.3904876598413;1039.3815679670583;1052.489542571852;1057.7620035492107;3807.695384369244;3872.244912242086;3890.9610903891166;3901.31726947783;3929.6070392961046;10790.784184316426;10995.945020275007;11060.612878549373;11066.833997490045;11134.27627204229;8632.697855575025;9346.205572526276;10057.044580764816;11076.501557429934;11101.444927753742;7626.771196864103;8238.50568965864;8306.501609903426;8350;8431.578421079044;5706.629069110661;5820.592558520862;5853.326867410302;5886.852828679317;5915.145707626381;10195.337303075275;10211.978802120026;10236.948815255875;10241;10345.534450949875;10219.284650074424;10488.26582139243;10526.947365263124;10561.366318020637;10618.1505479563;6626.56927299724;6814.829629259309;7117.572945623279;7143.285671432815;7255.455840811855;7295.781126566211;7362.705491780269;8630.956845215735;8664.740057798275;8668.696595619123;7423.554586724814;7597.6201189941385;7735.9613201933635;7787.727429539939;7856.175101614248;7295.270472952662;7522.059742532184;7531;7532.623368831646;7544.811379715551;5903.409659034062;7138.714451422093;7144.999700042103;7146.035285236427;7176.820579485555;4218.367244913287;4236.7881605918965;4911.3369695090705;5000.399952005782;5067.543921047123;4965.280034395065;5028.572571331478;5061.6962982221185;5086.415062267886;5087.465816089405 06:12:26 INFO - PROCESS | 29414 | |4;prototype.html;265.95478768609337;301.8098597883333;309.2238481411656;312.8779775887403;313.6267841268891;4571.657125715568;5230.744621290892;5526.866992266576;5534.28054352934;5651.491365777079;4325.048489332342;5460.535854452376;5482.890342193164;5498.670079795215;5588.804391846286;4198.307279298912;4246.723962942398;4247.15056988602;4248.214080395137;4259.850905218318;3661.377565813818;4147.294959856817;4228.851990180329;4262.360645903123;4293.635041021517;4171.249175148472;4185.200363843546;4187.476565429321;4210.4947406311285;4258.595433433834;3464.5149679044953;3534.664206900366;3624.3476174288617;4140.0891803803115;4206.978965105171;3234.3046245057426;3684.2263124743836;3702.222533268017;3708.3510385682666;3730.6082861299715;3897.629725176104;4108;4300.956990430087;4820.758962051884;4950.727709975986;3737.112758057164;4177.248095342837;4818.566329030404;4821.709687898256;4836.903261934777;5038.949610503884;5814.3313518945015;5853.356130825606;5867.618604790675;5877.294724633029;2897.6522817261853;2969.8218106913437;3902.024493876531;3956.4460975463458;4021.2761702893467;5041.899162016776;5653.717314134276;5658.801941932013;6135.601185922901;6141.232345956755;3424.880129195466;3860.8069596520063;3958.148997965394;3965.266425711253;3982.212451284113;3676.786660402061;3715.238376132886;3800.9809950950066;4005.859794907164;4008.296473998539;3951.9802400988387;4476.932846007313;4478.373027776114;4747.715137091785;4753.691010084333;5891.558133140032;5909.527237820964;5924.259467566554;5982.282126144891;6004.579679422399;1120.8767035626074;1183.721825371037;1297.195738642029;1308.7251677147906;1368.8706816876118;775.2906090926851;792.4388953761081;884.9734308202454;891.0243283604443;919.7148883846029;5227.137522308853;5413.431589683105;5482.945170548323;5504.972475137599;5516.365617953907;5254.712595414148;5622.718864056781;5886.234789477427;6005.399460054047;6012.909806352908;4768.737719425465;5223.671854708176;5224.242484839753;5473.562115030788;5497.038018346773;2823.6329277194245;2918.985405072961;3049.1767222849708;3109.5802066721158;3202.6957439043254;5031.547160755476;5335.573154147659;5644.024591392979;6243.687815609202;6316.778912738124;5909.5863289569315;5910.822675319747;6158.951319097076;6176.474999624992;6287.559870808999;5955.374685657944;5988.514766371907;6285.308616052231;6355.173827402408;6363.077353783676;5228.686278823131;5344.690550815075;5702.631368471454;5789.565782566408;6005.549583781147;4815.6147508198555;5197.636165468381;5916.550445140968;6044.335123136363;6066.605670631395;5095;5522.723863806713;5878.353381128158;6289.465395441439;6341.904871427025;3412.9146771330916;3717.386631205821;3900.863469778544;3964.7224694271126;4000.559938406831;5278.3637072507645;5725.7137143141845;6034.185384972972;6059.848503787441;6068.423499767515;4939.629527785502;5059.139946209079;5296.205569164502;5487.012337779238;5751.367349591458;4887.315775791463;5032.421271553671;5282.630215884851;5808.651480911159;5811.699342486445;4705.317728929354;4770.570648641639;5342.252084708066;5554.555635549227;5659;4850.393700787402;5759.481646651654;5777.277840269966;5792.739326730223;5799.738102140253;4564.475085365226;4875.634327425528;5080.695158290514;5185.159268459643;5431.37539182999 06:12:26 INFO - PROCESS | 29414 | |5;yui.html;689.5483458334793;710.1797423975307;716.437596486758;752.4507109809839;758.5145506875597;15120.395184192634;15474.690506189869;15528.223588820556;15531.611709707264;15597.376104955802;13960.092593981384;14043.578692639237;14056.437742490314;14080.436782528686;14082.859171408283;668.5286872754721;689.1970853955162;821.5358322547771;843.4770442325766;844.8225872566737;845.6828689241535;846.7840700621364;846.8179341441589;847.4449235750593;854.9444286121413;888.835565420396;897.344938195118;898.81574277273;900.995495022524;901.085398320705;891.0109778146252;892.2460520859863;894.7047474333486;895.8880139982502;899.6626265150569;661.7055410342399;664.6875968294894;665.0689035350548;665.806915994361;666.4868051600289;11965;14457.060291081047;14520.346584403727;14528;14559.199244041574;11288.604898828502;11833.644990650295;12599.874001259961;13959.65100872476;14975.550733478012;9619.326647134703;10884.693836739563;11242.550297988153;11855;11927.701807454883;3424.2124311408515;3717.3866312058476;3781.300459415017;3817;3896.4350169225586;98782.5060874691;105128;113087.43456282748;114739;116739;10865.40240286776;10869.510872010778;11344.376059316817;11522.193446458836;11594.362310072858;23156.073757049868;23167;23235;23274.65088023647;23340.2997910063;8052.355811535063;8210.876836847452;8242.216989386;8439.367047471342;8487.745367638981;4481.126180394857;4544.750038747835;4547.181507328646;4627.652926030494;4641.25739881624;3617.81910904459;3657.396529572644;3707.35121353762;3732.8506859725308;3900.3369427197445;739.548875186136;741.6699568691988;749.2694622742891;751.9661615227328;762.5805806806235;537.6962016460687;636.1189752193245;659.1990731261541;661.4840424468922;671.5265737654942;9040.412373195853;9565.378250413702;9578.090081442251;9591.856122158173;9847.803043939224;515.4510446374599;567.5828266224322;610.4353473037422;687.4294335701356;688.0711040095831;3489.6281878326013;4041.6160464755803;4107.301758701028;4359.237133501688;4647.186742320148;94049.0595094054;128382;131675.02487462695;145001.27499362436;148524;136027;136914.3154284222;137606;140513.29743351217;142974.28512857578;82945;94881;113707;117869.41065294619;120313;8781.692640757543;9026.142516460926;9041.050689677752;9105.317101217568;9109.18017378439;48311.516884832105;62736.686316569954;63310.366896330444;66055;66439.02390249148;74344.62827685828;95199.52400237955;96601;96825;99505;11668.066554675435;11670.358130302915;11773.234739742233;12015.579454719043;12077;13044.152130111512;13140.211587304791;13154.34228288601;13249.536266230636;13389.866101338863;12077.154599177973;12102.636920892388;12222.388880556115;12246.326452045223;12360.38198090074;12161.148719589897;12195.390230488618;12199.51201951912;12276.570320038756;12320.876791232331;11448.255863368855;11486.425678716198;11861.5848445304;11907.16649834538;11976.700582485508;10458.424786636808;10479.580816767244;10636.627718029831;10740.033396994308;10841;10095.495225238856;10680.83978740335;10693.144548436261;10718.142548595937;10808.783824323627 06:12:26 INFO - PROCESS | 29414 | __end_tp_report 06:12:26 INFO - PROCESS | 29414 | __start_cc_report 06:12:26 INFO - PROCESS | 29414 | _x_x_mozilla_cycle_collect,370 06:12:26 INFO - PROCESS | 29414 | __end_cc_report 06:12:26 INFO - PROCESS | 29414 | __startTimestamp1478265146144__endTimestamp 06:12:26 INFO - PROCESS | 29414 | 06:12:26 INFO - PROCESS | 29414 | ------- Summary: start ------- 06:12:26 INFO - PROCESS | 29414 | Number of tests: 6 06:12:26 INFO - PROCESS | 29414 | 06:12:26 INFO - PROCESS | 29414 | [#0] dojo.html Cycles:165 Average:5768.64 Median:6038.09 stddev:696.80 (11.5%) stddev-sans-first:672.46 06:12:26 INFO - PROCESS | 29414 | Values: 3343.6 3371.1 3379.0 3381.3 3397.8 5728.6 5743.6 5779.5 5825.8 5827.2 4506.5 5818.2 5834.9 5844.4 5871.3 4309.8 4471.4 5255.3 5331.0 5351.6 4667.0 5334.8 5351.1 5393.8 5397.2 5232.9 5256.2 5339.4 5346.0 5363.5 5246.0 5308.5 5324.7 5336.7 5387.1 4485.4 5145.5 5277.9 5280.2 5283.2 4852.5 5655.3 5783.2 5904.2 5919.4 5943.6 6135.5 6162.5 6246.8 6285.5 5696.4 6289.4 6340.4 6358.4 6373.1 5879.6 5888.4 5894.6 5901.6 5910.7 6257.0 6266.0 6269.0 6289.3 6323.7 6203.1 6229.9 6247.2 6257.2 6268.2 6252.6 6308.6 6350.6 6352.6 6356.3 6145.6 6188.3 6212.1 6242.9 6306.1 6241.7 6298.7 6307.9 6335.1 6338.4 4961.0 4971.7 4972.7 4982.7 4999.4 4329.4 4385.6 4421.8 4461.8 4465.9 5799.0 5918.0 5953.6 6011.3 6061.5 6277.7 6309.4 6312.0 6328.5 6359.6 5345.7 5746.1 5855.2 6000.3 6038.1 4410.6 5482.3 5483.9 5487.8 5515.0 6356.7 6380.8 6381.6 6389.4 6391.8 6131.3 6183.6 6220.1 6258.0 6288.1 6410.9 6418.6 6432.3 6435.2 6439.8 6232.3 6238.6 6246.1 6251.1 6269.9 6169.1 6229.9 6235.3 6285.5 6309.4 5983.5 6136.2 6142.4 6176.4 6200.3 6196.8 6202.1 6204.4 6210.2 6221.1 4443.4 5937.9 6020.3 6106.9 6167.2 6100.4 6113.2 6119.2 6126.7 6191.9 6023.8 6028.1 6031.7 6051.2 6059.3 06:12:26 INFO - PROCESS | 29414 | 06:12:26 INFO - PROCESS | 29414 | [#1] ext.html Cycles:180 Average:83551.36 Median:19291.12 stddev:209426.59 (1085.6%) stddev-sans-first:209921.00 06:12:26 INFO - PROCESS | 29414 | Values: 385.8 420.3 431.8 432.1 499.3 39604.2 41927.4 42004.4 42008.4 42012.4 34283.1 38854.2 41046.4 43062.1 43444.0 9885.1 10029.1 10036.6 10081.6 10121.6 8898.3 9955.7 10079.6 10090.9 10157.4 10080.7 10097.8 10136.5 10138.6 10153.6 10044.0 10079.0 10101.6 10110.1 10144.8 9826.6 9905.9 9926.5 9948.2 9962.7 40212.2 40388.4 40418.8 40461.8 40630.8 3443.3 3524.8 3639.5 3867.0 4038.8 23912.6 30564.7 32182.4 32441.7 32619.7 3245.8 3282.1 3296.8 3361.6 3383.6 537233.0 537269.3 541334.0 542872.0 544087.3 33195.7 34547.8 62306.0 62505.4 62888.0 34973.7 35298.6 35339.5 35405.1 35589.0 15417.1 15470.6 15481.3 15541.6 15592.2 12711.3 13101.4 13198.9 13211.6 13234.5 7806.2 7821.6 7827.7 7882.1 7892.9 3262.5 3287.6 3291.0 3291.4 3312.6 853.8 913.9 914.2 926.9 1027.7 30174.8 30462.1 30892.4 31081.0 31369.0 938.7 984.7 1133.8 1142.5 1144.6 15014.7 15703.0 15738.1 15779.1 15946.2 1011557.0 1028969.0 1032725.0 1034465.0 1038641.0 58835.4 59434.0 59529.4 59644.4 59743.7 1247.8 1349.6 1375.4 1398.5 1400.8 29121.6 31417.7 31583.1 31598.8 32044.5 51374.5 51499.5 51911.7 51945.0 51980.2 661000.0 664763.0 664821.0 664899.0 666188.0 21751.7 22513.5 26344.2 26747.7 27884.6 46506.0 47281.8 47723.8 47881.0 47981.0 37409.4 39160.4 39458.4 40154.8 40375.6 38935.4 39116.2 39815.6 40461.8 40469.6 38199.4 38519.8 39199.8 39213.0 40428.0 24957.3 28664.1 30093.1 32461.8 35057.5 21647.0 23457.9 25636.0 26134.6 26192.7 06:12:26 INFO - PROCESS | 29414 | 06:12:26 INFO - PROCESS | 29414 | [#2] jquery.html Cycles:180 Average:34349.17 Median:13452.04 stddev:99787.06 (741.8%) stddev-sans-first:100034.37 06:12:26 INFO - PROCESS | 29414 | Values: 365.2 371.6 378.5 382.5 398.1 19239.9 20358.5 20833.0 20852.5 20958.1 17724.1 18716.3 20051.5 20509.9 20928.1 3971.6 5241.0 5772.5 5942.6 6018.5 5895.9 5976.0 6017.8 6025.9 6027.7 5703.2 5781.3 5802.6 5940.6 5991.6 4699.7 4724.4 5301.6 5887.3 5906.0 4875.3 4996.1 5087.8 5145.7 5158.0 19335.8 24620.8 25727.6 25911.5 26052.1 2221.8 2237.8 2283.3 2482.2 3074.4 11916.5 14957.0 15369.5 15437.5 15710.8 1858.2 1874.6 1891.9 1894.4 1934.3 102908.5 109628.5 116228.0 116622.4 116791.0 8530.4 10648.7 10716.1 10984.9 11085.2 13547.3 13572.2 13592.6 13600.9 13620.5 8528.1 8698.0 8789.9 8884.2 8929.6 8827.4 8886.7 8921.8 9031.5 9061.1 6478.4 6625.7 6656.1 6673.2 6683.3 1576.6 1846.5 1856.9 1871.0 1895.9 985.6 987.1 1021.5 1021.9 1052.2 21219.7 21780.8 21861.2 22021.0 22030.7 938.7 939.6 974.1 1021.9 1028.7 9580.2 11397.8 11489.5 11547.7 11695.8 520238.0 612284.0 614435.0 626138.0 627888.0 92421.2 105810.0 107811.5 117115.0 118752.4 926.3 1004.5 1006.7 1065.1 1070.0 18301.8 18789.3 18936.8 19158.9 19310.0 40222.2 48967.5 54278.0 57165.0 57412.9 75194.9 75658.6 77317.1 77684.6 77840.8 7161.5 7983.5 8004.9 8120.8 8408.7 9051.4 10742.6 12080.5 12385.7 12910.9 8271.3 9703.7 11069.0 11342.5 11738.1 10171.3 10438.9 11367.3 11431.9 11615.0 10058.7 11091.7 11483.9 11487.2 11625.8 7771.4 7983.2 8324.2 8378.3 8380.8 8194.4 11125.3 11380.1 11531.5 11685.9 06:12:26 INFO - PROCESS | 29414 | 06:12:26 INFO - PROCESS | 29414 | [#3] mootools.html Cycles:180 Average:5736.88 Median:4663.36 stddev:3230.21 (69.3%) stddev-sans-first:3223.00 06:12:26 INFO - PROCESS | 29414 | Values: 1423.0 1463.5 1639.4 1772.4 1801.0 8078.8 8353.4 8565.8 9174.1 9195.0 8565.4 8916.1 8923.0 9009.0 9017.0 2368.4 2410.8 2412.3 2422.6 2430.6 2019.4 2065.5 2395.3 2416.1 2417.9 2405.8 2413.6 2421.7 2432.9 2437.1 2371.5 2390.3 2397.8 2406.4 2411.8 2381.9 2403.7 2405.2 2405.5 2414.7 8960.6 9024.4 9072.1 9093.9 9106.7 5157.4 5315.7 5317.0 5319.5 5325.1 3667.7 3708.0 3737.8 3741.9 3749.6 1100.2 1104.3 1104.7 1116.8 1128.9 11696.4 11833.3 11939.0 11954.9 11962.9 4154.0 4726.6 4744.5 4751.8 4912.2 9932.4 10015.1 10027.7 10034.9 10038.0 5388.0 5396.6 5404.8 5408.3 5428.4 4448.7 4600.1 4806.7 4930.9 4950.2 3962.8 3993.7 4070.3 4096.2 4103.3 1317.1 1327.0 1330.3 1333.3 1346.6 791.0 798.3 891.3 896.9 946.7 5540.8 5746.7 5764.2 5836.7 5923.9 727.5 1024.4 1039.4 1052.5 1057.8 3807.7 3872.2 3891.0 3901.3 3929.6 10790.8 10995.9 11060.6 11066.8 11134.3 8632.7 9346.2 10057.0 11076.5 11101.4 7626.8 8238.5 8306.5 8350.0 8431.6 5706.6 5820.6 5853.3 5886.9 5915.1 10195.3 10212.0 10236.9 10241.0 10345.5 10219.3 10488.3 10526.9 10561.4 10618.2 6626.6 6814.8 7117.6 7143.3 7255.5 7295.8 7362.7 8631.0 8664.7 8668.7 7423.6 7597.6 7736.0 7787.7 7856.2 7295.3 7522.1 7531.0 7532.6 7544.8 5903.4 7138.7 7145.0 7146.0 7176.8 4218.4 4236.8 4911.3 5000.4 5067.5 4965.3 5028.6 5061.7 5086.4 5087.5 06:12:26 INFO - PROCESS | 29414 | 06:12:26 INFO - PROCESS | 29414 | [#4] prototype.html Cycles:180 Average:4598.12 Median:5069.92 stddev:1457.55 (28.7%) stddev-sans-first:1424.90 06:12:26 INFO - PROCESS | 29414 | Values: 266.0 301.8 309.2 312.9 313.6 4571.7 5230.7 5526.9 5534.3 5651.5 4325.0 5460.5 5482.9 5498.7 5588.8 4198.3 4246.7 4247.2 4248.2 4259.9 3661.4 4147.3 4228.9 4262.4 4293.6 4171.2 4185.2 4187.5 4210.5 4258.6 3464.5 3534.7 3624.3 4140.1 4207.0 3234.3 3684.2 3702.2 3708.4 3730.6 3897.6 4108.0 4301.0 4820.8 4950.7 3737.1 4177.2 4818.6 4821.7 4836.9 5038.9 5814.3 5853.4 5867.6 5877.3 2897.7 2969.8 3902.0 3956.4 4021.3 5041.9 5653.7 5658.8 6135.6 6141.2 3424.9 3860.8 3958.1 3965.3 3982.2 3676.8 3715.2 3801.0 4005.9 4008.3 3952.0 4476.9 4478.4 4747.7 4753.7 5891.6 5909.5 5924.3 5982.3 6004.6 1120.9 1183.7 1297.2 1308.7 1368.9 775.3 792.4 885.0 891.0 919.7 5227.1 5413.4 5482.9 5505.0 5516.4 5254.7 5622.7 5886.2 6005.4 6012.9 4768.7 5223.7 5224.2 5473.6 5497.0 2823.6 2919.0 3049.2 3109.6 3202.7 5031.5 5335.6 5644.0 6243.7 6316.8 5909.6 5910.8 6159.0 6176.5 6287.6 5955.4 5988.5 6285.3 6355.2 6363.1 5228.7 5344.7 5702.6 5789.6 6005.5 4815.6 5197.6 5916.6 6044.3 6066.6 5095.0 5522.7 5878.4 6289.5 6341.9 3412.9 3717.4 3900.9 3964.7 4000.6 5278.4 5725.7 6034.2 6059.8 6068.4 4939.6 5059.1 5296.2 5487.0 5751.4 4887.3 5032.4 5282.6 5808.7 5811.7 4705.3 4770.6 5342.3 5554.6 5659.0 4850.4 5759.5 5777.3 5792.7 5799.7 4564.5 4875.6 5080.7 5185.2 5431.4 06:12:26 INFO - PROCESS | 29414 | 06:12:26 INFO - PROCESS | 29414 | [#5] yui.html Cycles:180 Average:24223.79 Median:3725.12 stddev:38890.01 (1044.0%) stddev-sans-first:38958.96 06:12:26 INFO - PROCESS | 29414 | Values: 689.5 710.2 716.4 752.5 758.5 15120.4 15474.7 15528.2 15531.6 15597.4 13960.1 14043.6 14056.4 14080.4 14082.9 668.5 689.2 821.5 843.5 844.8 845.7 846.8 846.8 847.4 854.9 888.8 897.3 898.8 901.0 901.1 891.0 892.2 894.7 895.9 899.7 661.7 664.7 665.1 665.8 666.5 11965.0 14457.1 14520.3 14528.0 14559.2 11288.6 11833.6 12599.9 13959.7 14975.6 9619.3 10884.7 11242.6 11855.0 11927.7 3424.2 3717.4 3781.3 3817.0 3896.4 98782.5 105128.0 113087.4 114739.0 116739.0 10865.4 10869.5 11344.4 11522.2 11594.4 23156.1 23167.0 23235.0 23274.7 23340.3 8052.4 8210.9 8242.2 8439.4 8487.7 4481.1 4544.8 4547.2 4627.7 4641.3 3617.8 3657.4 3707.4 3732.9 3900.3 739.5 741.7 749.3 752.0 762.6 537.7 636.1 659.2 661.5 671.5 9040.4 9565.4 9578.1 9591.9 9847.8 515.5 567.6 610.4 687.4 688.1 3489.6 4041.6 4107.3 4359.2 4647.2 94049.1 128382.0 131675.0 145001.3 148524.0 136027.0 136914.3 137606.0 140513.3 142974.3 82945.0 94881.0 113707.0 117869.4 120313.0 8781.7 9026.1 9041.1 9105.3 9109.2 48311.5 62736.7 63310.4 66055.0 66439.0 74344.6 95199.5 96601.0 96825.0 99505.0 11668.1 11670.4 11773.2 12015.6 12077.0 13044.2 13140.2 13154.3 13249.5 13389.9 12077.2 12102.6 12222.4 12246.3 12360.4 12161.1 12195.4 12199.5 12276.6 12320.9 11448.3 11486.4 11861.6 11907.2 11976.7 10458.4 10479.6 10636.6 10740.0 10841.0 10095.5 10680.8 10693.1 10718.1 10808.8 06:12:26 INFO - PROCESS | 29414 | -------- Summary: end -------- 06:12:26 INFO - PROCESS | 29414 | 06:12:26 INFO - TEST-INFO | 29414: exit 0 06:12:26 INFO - TEST-OK | dromaeo_css | took 1113512ms 06:12:26 INFO - TEST-START | kraken 06:12:26 INFO - operating with platform_type : mac_ 06:12:26 INFO - Initialising browser for kraken test... 06:12:26 INFO - TEST-INFO | started process 29419 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/tmp78FpMs/profile http://localhost:52330/getInfo.html) 06:12:29 INFO - PROCESS | 29419 | __metrics Screen width/height:1600/1200 06:12:29 INFO - PROCESS | 29419 | colorDepth:24 06:12:29 INFO - PROCESS | 29419 | Browser inner width/height: 1024/689 06:12:29 INFO - PROCESS | 29419 | __metrics 06:12:29 ERROR - PROCESS | 29419 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 06:12:29 INFO - TEST-INFO | 29419: exit 0 06:12:29 INFO - Browser initialized. 06:12:29 INFO - Running cycle 1/1 for kraken test... 06:12:29 INFO - TEST-INFO | started process 29421 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/tmp78FpMs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:12:42 INFO - PROCESS | 29421 | RSS: Main: 225370112 06:12:42 INFO - PROCESS | 29421 | 06:12:44 INFO - PROCESS | 29421 | Cycle 1(1): loaded http://localhost:52330/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52330/tests/kraken/driver.html?testName=audio-beat-detection) 06:12:45 INFO - PROCESS | 29421 | RSS: Main: 237895680 06:12:45 INFO - PROCESS | 29421 | 06:12:48 INFO - PROCESS | 29421 | Cycle 1(1): loaded http://localhost:52330/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52330/tests/kraken/driver.html?testName=audio-dft) 06:12:49 INFO - PROCESS | 29421 | RSS: Main: 245342208 06:12:49 INFO - PROCESS | 29421 | 06:12:52 INFO - PROCESS | 29421 | Cycle 1(1): loaded http://localhost:52330/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52330/tests/kraken/driver.html?testName=audio-fft) 06:12:53 INFO - PROCESS | 29421 | RSS: Main: 249102336 06:12:53 INFO - PROCESS | 29421 | 06:12:55 INFO - PROCESS | 29421 | Cycle 1(1): loaded http://localhost:52330/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52330/tests/kraken/driver.html?testName=audio-oscillator) 06:12:55 INFO - PROCESS | 29421 | RSS: Main: 249454592 06:12:55 INFO - PROCESS | 29421 | 06:12:57 INFO - PROCESS | 29421 | Cycle 1(1): loaded http://localhost:52330/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52330/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:12:58 INFO - PROCESS | 29421 | RSS: Main: 250728448 06:12:58 INFO - PROCESS | 29421 | 06:13:01 INFO - PROCESS | 29421 | Cycle 1(1): loaded http://localhost:52330/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52330/tests/kraken/driver.html?testName=imaging-darkroom) 06:13:01 INFO - PROCESS | 29421 | RSS: Main: 251674624 06:13:01 INFO - PROCESS | 29421 | 06:13:04 INFO - PROCESS | 29421 | Cycle 1(1): loaded http://localhost:52330/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52330/tests/kraken/driver.html?testName=imaging-desaturate) 06:13:05 INFO - PROCESS | 29421 | RSS: Main: 251858944 06:13:05 INFO - PROCESS | 29421 | 06:13:08 INFO - PROCESS | 29421 | Cycle 1(1): loaded http://localhost:52330/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52330/tests/kraken/driver.html?testName=json-parse-financial) 06:13:09 INFO - PROCESS | 29421 | RSS: Main: 252338176 06:13:09 INFO - PROCESS | 29421 | 06:13:10 INFO - PROCESS | 29421 | Cycle 1(1): loaded http://localhost:52330/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52330/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:13:11 INFO - PROCESS | 29421 | RSS: Main: 251617280 06:13:11 INFO - PROCESS | 29421 | 06:13:13 INFO - PROCESS | 29421 | Cycle 1(1): loaded http://localhost:52330/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52330/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:13:14 INFO - PROCESS | 29421 | RSS: Main: 251682816 06:13:14 INFO - PROCESS | 29421 | 06:13:16 INFO - PROCESS | 29421 | Cycle 1(1): loaded http://localhost:52330/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52330/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:13:16 INFO - PROCESS | 29421 | RSS: Main: 251633664 06:13:16 INFO - PROCESS | 29421 | 06:13:19 INFO - PROCESS | 29421 | Cycle 1(1): loaded http://localhost:52330/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52330/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:13:20 INFO - PROCESS | 29421 | RSS: Main: 252162048 06:13:20 INFO - PROCESS | 29421 | 06:13:23 INFO - PROCESS | 29421 | Cycle 1(1): loaded http://localhost:52330/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52330/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:13:24 INFO - PROCESS | 29421 | RSS: Main: 251822080 06:13:24 INFO - PROCESS | 29421 | 06:13:26 INFO - PROCESS | 29421 | Cycle 1(1): loaded http://localhost:52330/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52330/tests/kraken/driver.html?testName=ai-astar) 06:13:26 INFO - PROCESS | 29421 | RSS: Main: 253177856 06:13:26 INFO - PROCESS | 29421 | 06:13:26 INFO - PROCESS | 29421 | __start_tp_report 06:13:26 INFO - PROCESS | 29421 | _x_x_mozilla_page_load 06:13:26 INFO - PROCESS | 29421 | _x_x_mozilla_page_load_details 06:13:26 INFO - PROCESS | 29421 | |i|pagename|runs| 06:13:26 INFO - PROCESS | 29421 | |0;ai-astar;118;117;120;117;141;120;100;171;176;126 06:13:26 INFO - PROCESS | 29421 | |1;audio-beat-detection;151;110;108;157;110;111;114;142;176;117 06:13:26 INFO - PROCESS | 29421 | |2;audio-dft;206;200;237;201;197;210;199;196;199;198 06:13:26 INFO - PROCESS | 29421 | |3;audio-fft;81;62;75;108;87;83;50;74;104;50 06:13:26 INFO - PROCESS | 29421 | |4;audio-oscillator;80;74;121;105;100;102;88;71;68;91 06:13:26 INFO - PROCESS | 29421 | |5;imaging-gaussian-blur;90;87;91;93;90;86;93;126;90;89 06:13:26 INFO - PROCESS | 29421 | |6;imaging-darkroom;96;94;95;95;96;96;95;97;95;97 06:13:26 INFO - PROCESS | 29421 | |7;imaging-desaturate;90;102;89;76;79;130;103;98;149;144 06:13:26 INFO - PROCESS | 29421 | |8;json-parse-financial;56;54;58;56;61;71;91;55;54;82 06:13:26 INFO - PROCESS | 29421 | |9;json-stringify-tinderbox;75;78;79;79;75;68;70;70;63;65 06:13:26 INFO - PROCESS | 29421 | |10;stanford-crypto-aes;86;97;105;102;82;78;98;105;75;94 06:13:26 INFO - PROCESS | 29421 | |11;stanford-crypto-ccm;133;160;150;128;142;138;143;139;203;151 06:13:26 INFO - PROCESS | 29421 | |12;stanford-crypto-pbkdf2;166;184;177;164;180;165;165;168;163;166 06:13:26 INFO - PROCESS | 29421 | |13;stanford-crypto-sha256-iterative;67;70;71;71;89;90;87;66;66;66 06:13:26 INFO - PROCESS | 29421 | __end_tp_report 06:13:26 INFO - PROCESS | 29421 | __start_cc_report 06:13:26 INFO - PROCESS | 29421 | _x_x_mozilla_cycle_collect,978 06:13:26 INFO - PROCESS | 29421 | __end_cc_report 06:13:26 INFO - PROCESS | 29421 | __startTimestamp1478265206268__endTimestamp 06:13:26 INFO - PROCESS | 29421 | 06:13:26 INFO - PROCESS | 29421 | ------- Summary: start ------- 06:13:26 INFO - PROCESS | 29421 | Number of tests: 14 06:13:26 INFO - PROCESS | 29421 | 06:13:26 INFO - PROCESS | 29421 | [#0] ai-astar Cycles:10 Average:130.60 Median:123.00 stddev:24.75 (20.1%) stddev-sans-first:25.83 06:13:26 INFO - PROCESS | 29421 | Values: 118.0 117.0 120.0 117.0 141.0 120.0 100.0 171.0 176.0 126.0 06:13:26 INFO - PROCESS | 29421 | 06:13:26 INFO - PROCESS | 29421 | [#1] audio-beat-detection Cycles:10 Average:129.60 Median:129.50 stddev:24.72 (19.1%) stddev-sans-first:24.97 06:13:26 INFO - PROCESS | 29421 | Values: 151.0 110.0 108.0 157.0 110.0 111.0 114.0 142.0 176.0 117.0 06:13:26 INFO - PROCESS | 29421 | 06:13:26 INFO - PROCESS | 29421 | [#2] audio-dft Cycles:10 Average:204.30 Median:200.50 stddev:12.26 (6.1%) stddev-sans-first:12.99 06:13:26 INFO - PROCESS | 29421 | Values: 206.0 200.0 237.0 201.0 197.0 210.0 199.0 196.0 199.0 198.0 06:13:26 INFO - PROCESS | 29421 | 06:13:26 INFO - PROCESS | 29421 | [#3] audio-fft Cycles:10 Average:77.40 Median:74.50 stddev:19.82 (26.6%) stddev-sans-first:20.98 06:13:26 INFO - PROCESS | 29421 | Values: 81.0 62.0 75.0 108.0 87.0 83.0 50.0 74.0 104.0 50.0 06:13:26 INFO - PROCESS | 29421 | 06:13:26 INFO - PROCESS | 29421 | [#4] audio-oscillator Cycles:10 Average:90.00 Median:72.50 stddev:17.11 (23.6%) stddev-sans-first:17.77 06:13:26 INFO - PROCESS | 29421 | Values: 80.0 74.0 121.0 105.0 100.0 102.0 88.0 71.0 68.0 91.0 06:13:26 INFO - PROCESS | 29421 | 06:13:26 INFO - PROCESS | 29421 | [#5] imaging-gaussian-blur Cycles:10 Average:93.50 Median:90.00 stddev:11.64 (12.9%) stddev-sans-first:12.27 06:13:26 INFO - PROCESS | 29421 | Values: 90.0 87.0 91.0 93.0 90.0 86.0 93.0 126.0 90.0 89.0 06:13:26 INFO - PROCESS | 29421 | 06:13:26 INFO - PROCESS | 29421 | [#6] imaging-darkroom Cycles:10 Average:95.60 Median:96.00 stddev:0.97 (1.0%) stddev-sans-first:1.01 06:13:26 INFO - PROCESS | 29421 | Values: 96.0 94.0 95.0 95.0 96.0 96.0 95.0 97.0 95.0 97.0 06:13:26 INFO - PROCESS | 29421 | 06:13:26 INFO - PROCESS | 29421 | [#7] imaging-desaturate Cycles:10 Average:106.00 Median:77.50 stddev:26.10 (33.7%) stddev-sans-first:27.04 06:13:26 INFO - PROCESS | 29421 | Values: 90.0 102.0 89.0 76.0 79.0 130.0 103.0 98.0 149.0 144.0 06:13:26 INFO - PROCESS | 29421 | 06:13:26 INFO - PROCESS | 29421 | [#8] json-parse-financial Cycles:10 Average:63.80 Median:59.50 stddev:13.15 (22.1%) stddev-sans-first:13.64 06:13:26 INFO - PROCESS | 29421 | Values: 56.0 54.0 58.0 56.0 61.0 71.0 91.0 55.0 54.0 82.0 06:13:26 INFO - PROCESS | 29421 | 06:13:26 INFO - PROCESS | 29421 | [#9] json-stringify-tinderbox Cycles:10 Average:72.20 Median:75.00 stddev:5.83 (7.8%) stddev-sans-first:6.09 06:13:26 INFO - PROCESS | 29421 | Values: 75.0 78.0 79.0 79.0 75.0 68.0 70.0 70.0 63.0 65.0 06:13:26 INFO - PROCESS | 29421 | 06:13:26 INFO - PROCESS | 29421 | [#10] stanford-crypto-aes Cycles:10 Average:92.20 Median:84.00 stddev:11.17 (13.3%) stddev-sans-first:11.62 06:13:26 INFO - PROCESS | 29421 | Values: 86.0 97.0 105.0 102.0 82.0 78.0 98.0 105.0 75.0 94.0 06:13:26 INFO - PROCESS | 29421 | 06:13:26 INFO - PROCESS | 29421 | [#11] stanford-crypto-ccm Cycles:10 Average:148.70 Median:146.50 stddev:21.20 (14.5%) stddev-sans-first:21.71 06:13:26 INFO - PROCESS | 29421 | Values: 133.0 160.0 150.0 128.0 142.0 138.0 143.0 139.0 203.0 151.0 06:13:26 INFO - PROCESS | 29421 | 06:13:26 INFO - PROCESS | 29421 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.80 Median:167.00 stddev:7.57 (4.5%) stddev-sans-first:7.90 06:13:26 INFO - PROCESS | 29421 | Values: 166.0 184.0 177.0 164.0 180.0 165.0 165.0 168.0 163.0 166.0 06:13:26 INFO - PROCESS | 29421 | 06:13:26 INFO - PROCESS | 29421 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.30 Median:71.00 stddev:10.13 (14.3%) stddev-sans-first:10.40 06:13:26 INFO - PROCESS | 29421 | Values: 67.0 70.0 71.0 71.0 89.0 90.0 87.0 66.0 66.0 66.0 06:13:26 INFO - PROCESS | 29421 | -------- Summary: end -------- 06:13:26 INFO - PROCESS | 29421 | 06:13:27 INFO - TEST-INFO | 29421: exit 0 06:13:27 INFO - TEST-OK | kraken | took 60356ms 06:13:27 INFO - SUITE-END | took 1173s 06:13:27 INFO - Completed test suite (00:19:34) 06:13:27 INFO - javascript benchmark 06:13:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7309.690377569574, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3343.582052243468, 3371.140359208402, 3378.9863041087674, 3381.2561236527954, 3397.830108494576, 5728.57035722321, 5743.597948143632, 5779.50874175695, 5825.796097136601, 5827.213326200962, 4506.549345065492, 5818.2145410369585, 5834.912476312858, 5844.444777746118, 5871.266091738533, 4309.784510774449, 4471.374007638933, 5255.264263003182, 5330.973345133289, 5351.57187425005, 4666.953330466686, 5334.759935802898, 5351.063563876325, 5393.78424863007, 5397.217403476494, 5232.8691782705355, 5256.237845512398, 5339.385970613371, 5346.0, 5363.490468405515, 5246.0, 5308.5487733542695, 5324.680519168863, 5336.653117547347, 5387.1111266640955, 4485.416895803524, 5145.536901678829, 5277.920831187535, 5280.2343660169445, 5283.181106928432, 4852.4662287148385, 5655.26481557399, 5783.21926539916, 5904.1734157218025, 5919.408059194089, 5943.64338139713, 6135.508280839769, 6162.506999440034, 6246.781362652286, 6285.528585356116, 5696.3733989261145, 6289.40250676185, 6340.397662222082, 6358.395952384516, 6373.075903993941, 5879.559033072451, 5888.411158884077, 5894.616849904743, 5901.616394934315, 5910.704464776744, 6257.0, 6265.966115590876, 6268.968655156695, 6289.276733175743, 6323.715432805535, 6203.069539569101, 6229.875402491924, 6247.187865577446, 6257.217847769029, 6268.153799237045, 6252.624842509464, 6308.589941653778, 6350.555461117678, 6352.618842869442, 6356.300806911236, 6145.555794388315, 6188.319284878659, 6212.099245609452, 6242.937570624235, 6306.054091886162, 6241.656708881055, 6298.685065746694, 6307.905381419282, 6335.11308416822, 6338.429541341301, 4960.950390496048, 4971.701697898137, 4972.72650004246, 4982.6512144149565, 4999.425066117443, 4329.350597410414, 4385.583369579948, 4421.845235416745, 4461.843835465743, 4465.910681786411, 5798.971005144947, 5918.0, 5953.553483488756, 6011.3086994995265, 6061.454469097803, 6277.686115694197, 6309.432151106423, 6311.958526843019, 6328.525360597973, 6359.618422894641, 5345.705986170798, 5746.13807928814, 5855.180274761537, 6000.279966403972, 6038.094285857069, 4410.558944105564, 5482.2873026506295, 5483.862903427366, 5487.75305111271, 5515.0, 6356.682165891687, 6380.840478988062, 6381.617102973836, 6389.361063893573, 6391.840203994844, 6131.315499378873, 6183.5671502994355, 6220.066989951543, 6257.968710156602, 6288.11966324724, 6410.871782564416, 6418.614883107029, 6432.3246059164985, 6435.195600549931, 6439.774607888889, 6232.283287421823, 6238.625682458885, 6246.094316324198, 6251.124842521959, 6269.937300626935, 6169.105479705508, 6229.937700623117, 6235.282942461494, 6285.49716022708, 6309.432151106423, 5983.4914032306, 6136.21274067861, 6142.3759981611065, 6176.382361763967, 6200.3489633589625, 6196.845078872884, 6202.069689546604, 6204.441600255998, 6210.161628180319, 6221.129041934042, 4443.377927090274, 5937.851553711192, 6020.277566692025, 6106.877862442815, 6167.198264225622, 6100.359462256399, 6113.205283313141, 6119.197913140417, 6126.693665316628, 6191.907121393093, 6023.849403764941, 6028.125921741411, 6031.69841507914, 6051.213342265477, 6059.303180134341], "value": 5724.146896967779, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.8263781298416, 420.28761249681804, 431.8035293941257, 432.1335721877635, 499.26109358149915, 39604.20791584167, 41927.371089433684, 42004.369934450966, 42008.36987445187, 42012.36981445281, 34283.142921426974, 38854.22291554167, 41046.384304235464, 43062.138757224835, 43444.0, 9885.060919212681, 10029.097381235688, 10036.59853605855, 10081.647142350019, 10121.645742399018, 8898.28813694906, 9955.651552195675, 10079.596816127383, 10090.899091009069, 10157.441340726256, 10080.69757907264, 10097.798044039151, 10136.49317534124, 10138.594456221743, 10153.593856245741, 10043.99560043997, 10079.0, 10101.646442374555, 10110.090091891692, 10144.797104057914, 9826.557804898797, 9905.90094099057, 9926.45404502752, 9948.154406875425, 9962.651307204213, 40212.195756085006, 40388.394174087414, 40418.79790601058, 40461.79769101165, 40630.79684601558, 3443.2596991646915, 3524.7708898921487, 3639.4540818877117, 3867.0139114525896, 4038.7980600970127, 23912.641310380186, 30564.694353056406, 32182.356352872812, 32441.675583244338, 32619.67380326214, 3245.789023713451, 3282.0810173151553, 3296.76922615417, 3361.596608407007, 3383.5770528683915, 537233.0, 537269.3136534331, 541334.0, 542872.0, 544087.2795636036, 33195.66804331974, 34547.79082732143, 62306.0, 62505.374946249955, 62888.0, 34973.65026349704, 35298.64701353005, 35339.4699079514, 35405.114872128404, 35589.0, 15417.074975501506, 15470.613234669223, 15481.303341349667, 15541.611459713598, 15592.220388980506, 12711.300878451773, 13101.41043653038, 13198.934005329911, 13211.603651890458, 13234.536791212262, 7806.219378062262, 7821.648025838851, 7827.726029588937, 7882.09355924076, 7892.921070789219, 3262.4780035194253, 3287.6054873414864, 3291.0253847691674, 3291.358185153872, 3312.569365982407, 853.8420392227333, 913.853783394667, 914.2183433164681, 926.9165775080276, 1027.6505987964129, 30174.84912575467, 30462.086137415914, 30892.382152357277, 31081.0, 31369.0, 938.7136923238342, 984.6898227058454, 1133.7732453509332, 1142.4687520303098, 1144.5789123020018, 15014.699706005818, 15703.0, 15738.134402607737, 15779.132147731985, 15946.20268986546, 1011557.0, 1028969.0, 1032725.0, 1034465.0, 1038641.0, 58835.411645882996, 59434.0, 59529.40470595325, 59644.40355596475, 59743.70128149331, 1247.7691627049026, 1349.6153596225029, 1375.40170026039, 1398.489551313763, 1400.8319001719858, 29121.563176551947, 31417.68582314239, 31583.052508424786, 31598.842005789826, 32044.5193322105, 51374.486255138465, 51499.48500514947, 51911.74044129755, 51945.0, 51980.22029669634, 661000.0, 664763.0, 664821.0, 664899.0, 666188.0, 21751.673724893823, 22513.549729005656, 26344.209673709818, 26747.732522674523, 27884.58173127445, 46506.0, 47281.77376032067, 47723.761381192875, 47881.0, 47981.04037919292, 37409.43885841769, 39160.41259381054, 39458.40812387759, 40154.799226003684, 40375.59624403718, 38935.41596876106, 39116.2176756469, 39815.601843982346, 40461.79769101136, 40469.59530404776, 38199.42700859545, 38519.80740096282, 39199.80400097981, 39213.01967450837, 40427.98930026773, 24957.251282461555, 28664.136831105912, 30093.09720708382, 32461.837690811393, 35057.47413788744, 21647.0, 23457.882710587022, 25636.0, 26134.607980880683, 26192.73807261903], "value": 19087.819030712304, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [365.1765269317688, 371.58939371993955, 378.5306220286845, 382.45882076861244, 398.12015445864654, 19239.903800480995, 20358.491037724063, 20832.958352082373, 20852.478688032807, 20958.056887440063, 17724.1137943103, 18716.251349945986, 20051.498712532193, 20509.871957042356, 20928.058237379315, 3971.6226958439047, 5241.0, 5772.451617096369, 5942.554308426864, 6018.51851851853, 5895.911561326584, 5976.043832986723, 6017.789377371793, 6025.9096113558335, 6027.72875220614, 5703.230063941377, 5781.277340332458, 5802.5938184327115, 5940.61386009908, 5991.610545314541, 4699.741514216734, 4724.4094488188975, 5301.602379821509, 5887.322957859816, 5905.970470147665, 4875.317455556225, 4996.075725990703, 5087.79648814047, 5145.742712864379, 5158.045761534091, 19335.80664193354, 24620.753792462026, 25727.61408578873, 25911.481770364677, 26052.088176913716, 2221.766714494971, 2237.8209743220505, 2283.3264187064856, 2482.1808803095114, 3074.3851229754137, 11916.523339066427, 14957.027793193516, 15369.46206882765, 15437.459688910947, 15710.764338534931, 1858.1916866163263, 1874.6344462829754, 1891.877027993176, 1894.355918987551, 1934.2843148035176, 102908.48545757373, 109628.451857741, 116228.0, 116622.41688791587, 116791.0, 8530.360222983301, 10648.680539583826, 10716.089132423675, 10984.945075274572, 11085.168612354106, 13547.254900980344, 13572.1856688599, 13592.592222233348, 13600.86399135996, 13620.523281685093, 8528.104549022264, 8697.95651021741, 8789.912100879037, 8884.244839188612, 8929.553522323988, 8827.426217295855, 8886.688965886164, 8921.776955576162, 9031.548422578844, 9061.093890611019, 6478.4169424752, 6625.734970601122, 6656.068150458939, 6673.232578253466, 6683.331666833278, 1576.5979675182755, 1846.538365408648, 1856.851451883846, 1870.9532261693566, 1895.8672892897641, 985.5909797434128, 987.0604262623979, 1021.4637315409469, 1021.867157269565, 1052.2371280821496, 21219.68170477444, 21780.78219217819, 21861.234856779938, 22021.00905459226, 22030.669539956914, 938.7277689470113, 939.6006697153819, 974.133021610767, 1021.9029192226726, 1028.6502589119586, 9580.233581313478, 11397.829032564518, 11489.540418383338, 11547.653570392902, 11695.76608467843, 520238.0, 612284.0, 614435.0, 626138.0, 627888.0, 92421.15157696808, 105810.0, 107811.46094269636, 117115.0, 118752.40623796826, 926.333040211047, 1004.492731170754, 1006.6979906028163, 1065.1478816946567, 1070.0476575847501, 18301.816981830012, 18789.34237301688, 18936.810631894055, 19158.946257955948, 19310.034498275312, 40222.1955560893, 48967.51032489772, 54278.0, 57164.99922502693, 57412.85174296407, 75194.87207691779, 75658.6217068911, 77317.06707332362, 77684.61157694175, 77840.83238751536, 7161.4986950912935, 7983.481073730189, 8004.879926801219, 8120.75637730869, 8408.663653453794, 9051.366404351633, 10742.603461549948, 12080.45637946277, 12385.690357740768, 12910.870891290966, 8271.255586997198, 9703.708888733348, 11069.00378965897, 11342.546298148312, 11738.119641027128, 10171.338862973884, 10438.851726309947, 11367.317960922372, 11431.885681143081, 11615.0, 10058.698239052841, 11091.667249982513, 11483.885161148615, 11487.19589628718, 11625.76748465009, 7771.37828973692, 7983.20167983197, 8324.217841286516, 8378.329733621174, 8380.832383352177, 8194.426390152632, 11125.332480051224, 11380.089592832719, 11531.481083351437, 11685.948264656221], "value": 9603.555579692493, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1423.0, 1463.4731496661204, 1639.401618409281, 1772.3885259585438, 1800.954976125596, 8078.838423231532, 8353.415260931737, 8565.800787889693, 9174.128457796507, 9195.0, 8565.443246188994, 8916.108389161082, 8923.0, 9009.00900900902, 9017.0, 2368.3723813189517, 2410.819188560856, 2412.3124909400826, 2422.600270955299, 2430.586800243954, 2019.3538067818304, 2065.535254567718, 2395.341281147681, 2416.1060407649106, 2417.8791060446906, 2405.8075353971726, 2413.625887987365, 2421.6730741349957, 2432.8905199265987, 2437.0982736387473, 2371.4901296221396, 2390.306811024801, 2397.7722116398913, 2406.350285422926, 2411.782939535433, 2381.8570885746913, 2403.6755038069987, 2405.230326295586, 2405.4707964247837, 2414.7343792182846, 8960.596773145158, 9024.368294219406, 9072.09279072094, 9093.863592046124, 9106.681266155652, 5157.355330583677, 5315.654482458628, 5317.0163519748585, 5319.468053194688, 5325.094733895247, 3667.6699097081123, 3708.0, 3737.813109344549, 3741.850325986957, 3749.643783840531, 1100.1583788401879, 1104.3484344236938, 1104.6741211342674, 1116.7878103160374, 1128.8814674459227, 11696.415179241005, 11833.290002599872, 11939.044876409866, 11954.940225298818, 11962.88037119635, 4153.979230103831, 4726.574608285271, 4744.5492678195515, 4751.783145896422, 4912.164931961575, 9932.404055756677, 10015.098641122187, 10027.749306267402, 10034.899651003396, 10037.99620038005, 5388.003219404422, 5396.649217800909, 5404.8108316208745, 5408.269883565747, 5428.430014848384, 4448.733076015449, 4600.148972440043, 4806.735629540409, 4930.8767280818265, 4950.2079667253065, 3962.8018599069933, 3993.66053885423, 4070.287699652549, 4096.160287141129, 4103.343465045638, 1317.0846261847923, 1326.9867301326863, 1330.301591664384, 1333.3000174908057, 1346.5556366399064, 790.9914858555388, 798.2815466080574, 891.3047822698305, 896.8968568614692, 946.7301818981557, 5540.750666220029, 5746.744057874562, 5764.164196191528, 5836.737346819404, 5923.911141332884, 727.4689476681946, 1024.3904876598413, 1039.3815679670583, 1052.489542571852, 1057.7620035492107, 3807.695384369244, 3872.244912242086, 3890.9610903891166, 3901.31726947783, 3929.6070392961046, 10790.784184316426, 10995.945020275007, 11060.612878549373, 11066.833997490045, 11134.27627204229, 8632.697855575025, 9346.205572526276, 10057.044580764816, 11076.501557429934, 11101.444927753742, 7626.771196864103, 8238.50568965864, 8306.501609903426, 8350.0, 8431.578421079044, 5706.629069110661, 5820.592558520862, 5853.326867410302, 5886.852828679317, 5915.145707626381, 10195.337303075275, 10211.978802120026, 10236.948815255875, 10241.0, 10345.534450949875, 10219.284650074424, 10488.26582139243, 10526.947365263124, 10561.366318020637, 10618.1505479563, 6626.56927299724, 6814.829629259309, 7117.572945623279, 7143.285671432815, 7255.455840811855, 7295.781126566211, 7362.705491780269, 8630.956845215735, 8664.740057798275, 8668.696595619123, 7423.554586724814, 7597.6201189941385, 7735.9613201933635, 7787.727429539939, 7856.175101614248, 7295.270472952662, 7522.059742532184, 7531.0, 7532.623368831646, 7544.811379715551, 5903.409659034062, 7138.714451422093, 7144.999700042103, 7146.035285236427, 7176.820579485555, 4218.367244913287, 4236.7881605918965, 4911.3369695090705, 5000.399952005782, 5067.543921047123, 4965.280034395065, 5028.572571331478, 5061.6962982221185, 5086.415062267886, 5087.465816089405], "value": 4616.980748619612, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [265.95478768609337, 301.8098597883333, 309.2238481411656, 312.8779775887403, 313.6267841268891, 4571.657125715568, 5230.744621290892, 5526.866992266576, 5534.28054352934, 5651.491365777079, 4325.048489332342, 5460.535854452376, 5482.890342193164, 5498.670079795215, 5588.804391846286, 4198.307279298912, 4246.723962942398, 4247.15056988602, 4248.214080395137, 4259.850905218318, 3661.377565813818, 4147.294959856817, 4228.851990180329, 4262.360645903123, 4293.635041021517, 4171.249175148472, 4185.200363843546, 4187.476565429321, 4210.4947406311285, 4258.595433433834, 3464.5149679044953, 3534.664206900366, 3624.3476174288617, 4140.0891803803115, 4206.978965105171, 3234.3046245057426, 3684.2263124743836, 3702.222533268017, 3708.3510385682666, 3730.6082861299715, 3897.629725176104, 4108.0, 4300.956990430087, 4820.758962051884, 4950.727709975986, 3737.112758057164, 4177.248095342837, 4818.566329030404, 4821.709687898256, 4836.903261934777, 5038.949610503884, 5814.3313518945015, 5853.356130825606, 5867.618604790675, 5877.294724633029, 2897.6522817261853, 2969.8218106913437, 3902.024493876531, 3956.4460975463458, 4021.2761702893467, 5041.899162016776, 5653.717314134276, 5658.801941932013, 6135.601185922901, 6141.232345956755, 3424.880129195466, 3860.8069596520063, 3958.148997965394, 3965.266425711253, 3982.212451284113, 3676.786660402061, 3715.238376132886, 3800.9809950950066, 4005.859794907164, 4008.296473998539, 3951.9802400988387, 4476.932846007313, 4478.373027776114, 4747.715137091785, 4753.691010084333, 5891.558133140032, 5909.527237820964, 5924.259467566554, 5982.282126144891, 6004.579679422399, 1120.8767035626074, 1183.721825371037, 1297.195738642029, 1308.7251677147906, 1368.8706816876118, 775.2906090926851, 792.4388953761081, 884.9734308202454, 891.0243283604443, 919.7148883846029, 5227.137522308853, 5413.431589683105, 5482.945170548323, 5504.972475137599, 5516.365617953907, 5254.712595414148, 5622.718864056781, 5886.234789477427, 6005.399460054047, 6012.909806352908, 4768.737719425465, 5223.671854708176, 5224.242484839753, 5473.562115030788, 5497.038018346773, 2823.6329277194245, 2918.985405072961, 3049.1767222849708, 3109.5802066721158, 3202.6957439043254, 5031.547160755476, 5335.573154147659, 5644.024591392979, 6243.687815609202, 6316.778912738124, 5909.5863289569315, 5910.822675319747, 6158.951319097076, 6176.474999624992, 6287.559870808999, 5955.374685657944, 5988.514766371907, 6285.308616052231, 6355.173827402408, 6363.077353783676, 5228.686278823131, 5344.690550815075, 5702.631368471454, 5789.565782566408, 6005.549583781147, 4815.6147508198555, 5197.636165468381, 5916.550445140968, 6044.335123136363, 6066.605670631395, 5095.0, 5522.723863806713, 5878.353381128158, 6289.465395441439, 6341.904871427025, 3412.9146771330916, 3717.386631205821, 3900.863469778544, 3964.7224694271126, 4000.559938406831, 5278.3637072507645, 5725.7137143141845, 6034.185384972972, 6059.848503787441, 6068.423499767515, 4939.629527785502, 5059.139946209079, 5296.205569164502, 5487.012337779238, 5751.367349591458, 4887.315775791463, 5032.421271553671, 5282.630215884851, 5808.651480911159, 5811.699342486445, 4705.317728929354, 4770.570648641639, 5342.252084708066, 5554.555635549227, 5659.0, 4850.393700787402, 5759.481646651654, 5777.277840269966, 5792.739326730223, 5799.738102140253, 4564.475085365226, 4875.634327425528, 5080.695158290514, 5185.159268459643, 5431.37539182999], "value": 4128.375020613605, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [689.5483458334793, 710.1797423975307, 716.437596486758, 752.4507109809839, 758.5145506875597, 15120.395184192634, 15474.690506189869, 15528.223588820556, 15531.611709707264, 15597.376104955802, 13960.092593981384, 14043.578692639237, 14056.437742490314, 14080.436782528686, 14082.859171408283, 668.5286872754721, 689.1970853955162, 821.5358322547771, 843.4770442325766, 844.8225872566737, 845.6828689241535, 846.7840700621364, 846.8179341441589, 847.4449235750593, 854.9444286121413, 888.835565420396, 897.344938195118, 898.81574277273, 900.995495022524, 901.085398320705, 891.0109778146252, 892.2460520859863, 894.7047474333486, 895.8880139982502, 899.6626265150569, 661.7055410342399, 664.6875968294894, 665.0689035350548, 665.806915994361, 666.4868051600289, 11965.0, 14457.060291081047, 14520.346584403727, 14528.0, 14559.199244041574, 11288.604898828502, 11833.644990650295, 12599.874001259961, 13959.65100872476, 14975.550733478012, 9619.326647134703, 10884.693836739563, 11242.550297988153, 11855.0, 11927.701807454883, 3424.2124311408515, 3717.3866312058476, 3781.300459415017, 3817.0, 3896.4350169225586, 98782.5060874691, 105128.0, 113087.43456282748, 114739.0, 116739.0, 10865.40240286776, 10869.510872010778, 11344.376059316817, 11522.193446458836, 11594.362310072858, 23156.073757049868, 23167.0, 23235.0, 23274.65088023647, 23340.2997910063, 8052.355811535063, 8210.876836847452, 8242.216989386, 8439.367047471342, 8487.745367638981, 4481.126180394857, 4544.750038747835, 4547.181507328646, 4627.652926030494, 4641.25739881624, 3617.81910904459, 3657.396529572644, 3707.35121353762, 3732.8506859725308, 3900.3369427197445, 739.548875186136, 741.6699568691988, 749.2694622742891, 751.9661615227328, 762.5805806806235, 537.6962016460687, 636.1189752193245, 659.1990731261541, 661.4840424468922, 671.5265737654942, 9040.412373195853, 9565.378250413702, 9578.090081442251, 9591.856122158173, 9847.803043939224, 515.4510446374599, 567.5828266224322, 610.4353473037422, 687.4294335701356, 688.0711040095831, 3489.6281878326013, 4041.6160464755803, 4107.301758701028, 4359.237133501688, 4647.186742320148, 94049.0595094054, 128382.0, 131675.02487462695, 145001.27499362436, 148524.0, 136027.0, 136914.3154284222, 137606.0, 140513.29743351217, 142974.28512857578, 82945.0, 94881.0, 113707.0, 117869.41065294619, 120313.0, 8781.692640757543, 9026.142516460926, 9041.050689677752, 9105.317101217568, 9109.18017378439, 48311.516884832105, 62736.686316569954, 63310.366896330444, 66055.0, 66439.02390249148, 74344.62827685828, 95199.52400237955, 96601.0, 96825.0, 99505.0, 11668.066554675435, 11670.358130302915, 11773.234739742233, 12015.579454719043, 12077.0, 13044.152130111512, 13140.211587304791, 13154.34228288601, 13249.536266230636, 13389.866101338863, 12077.154599177973, 12102.636920892388, 12222.388880556115, 12246.326452045223, 12360.38198090074, 12161.148719589897, 12195.390230488618, 12199.51201951912, 12276.570320038756, 12320.876791232331, 11448.255863368855, 11486.425678716198, 11861.5848445304, 11907.16649834538, 11976.700582485508, 10458.424786636808, 10479.580816767244, 10636.627718029831, 10740.033396994308, 10841.0, 10095.495225238856, 10680.83978740335, 10693.144548436261, 10718.142548595937, 10808.783824323627], "value": 7626.301829552942, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1548.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 120.0, 117.0, 141.0, 120.0, 100.0, 171.0, 176.0, 126.0], "value": 130.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 110.0, 108.0, 157.0, 110.0, 111.0, 114.0, 142.0, 176.0, 117.0], "value": 129.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [206.0, 200.0, 237.0, 201.0, 197.0, 210.0, 199.0, 196.0, 199.0, 198.0], "value": 204.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 62.0, 75.0, 108.0, 87.0, 83.0, 50.0, 74.0, 104.0, 50.0], "value": 77.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 74.0, 121.0, 105.0, 100.0, 102.0, 88.0, 71.0, 68.0, 91.0], "value": 90.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 87.0, 91.0, 93.0, 90.0, 86.0, 93.0, 126.0, 90.0, 89.0], "value": 93.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 94.0, 95.0, 95.0, 96.0, 96.0, 95.0, 97.0, 95.0, 97.0], "value": 95.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 102.0, 89.0, 76.0, 79.0, 130.0, 103.0, 98.0, 149.0, 144.0], "value": 106.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 54.0, 58.0, 56.0, 61.0, 71.0, 91.0, 55.0, 54.0, 82.0], "value": 63.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 78.0, 79.0, 79.0, 75.0, 68.0, 70.0, 70.0, 63.0, 65.0], "value": 72.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 97.0, 105.0, 102.0, 82.0, 78.0, 98.0, 105.0, 75.0, 94.0], "value": 92.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 160.0, 150.0, 128.0, 142.0, 138.0, 143.0, 139.0, 203.0, 151.0], "value": 148.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 184.0, 177.0, 164.0, 180.0, 165.0, 165.0, 168.0, 163.0, 166.0], "value": 169.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 70.0, 71.0, 71.0, 89.0, 90.0, 87.0, 66.0, 66.0, 66.0], "value": 74.3, "unit": "score"}]}]} 06:13:27 INFO - Return code: 0 06:13:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:13:27 ERROR - # TBPL SUCCESS # 06:13:27 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:13:27 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:13:27 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:13:27 INFO - 2016-11-04 06:13:27.624 screenresolution[29426:275831] starting screenresolution argv=screenresolution get 06:13:27 INFO - 2016-11-04 06:13:27.626 screenresolution[29426:275831] Display 0: 1600x1200x32@60 06:13:27 INFO - 2016-11-04 06:13:27.632 screenresolution[29427:275834] starting screenresolution argv=screenresolution list 06:13:27 INFO - Available Modes on Display 0 06:13:27 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:13:27 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:13:27 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:13:27 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:13:27 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:13:27 INFO - Intel Iris: 06:13:27 INFO - Chipset Model: Intel Iris 06:13:27 INFO - Type: GPU 06:13:27 INFO - Bus: Built-In 06:13:27 INFO - VRAM (Dynamic, Max): 1536 MB 06:13:27 INFO - Vendor: Intel (0x8086) 06:13:27 INFO - Device ID: 0x0a2e 06:13:27 INFO - Revision ID: 0x0009 06:13:27 INFO - Displays: 06:13:27 INFO - Display: 06:13:27 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:13:27 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:13:27 INFO - Display Serial Number: 1600x1200 60 06:13:27 INFO - Main Display: Yes 06:13:27 INFO - Mirror: Off 06:13:27 INFO - Online: Yes 06:13:27 INFO - Rotation: Supported 06:13:27 INFO - Return code: 0 06:13:27 INFO - Running post-action listener: _resource_record_post_action 06:13:27 INFO - [mozharness: 2016-11-04 13:13:27.867084Z] Finished run-tests step (success) 06:13:27 INFO - Running post-run listener: _resource_record_post_run 06:13:27 INFO - Total resource usage - Wall time: 1207s; CPU: 54.0%; Read bytes: 1556480; Write bytes: 667363328; Read time: 12; Write time: 2159 06:13:27 INFO - TinderboxPrint: CPU usage
54.3% 06:13:27 INFO - TinderboxPrint: I/O read bytes / time
1,556,480 / 12 06:13:27 INFO - TinderboxPrint: I/O write bytes / time
667,363,328 / 2,159 06:13:27 INFO - TinderboxPrint: CPU idle
2,209.5 (45.7%) 06:13:27 INFO - TinderboxPrint: CPU system
981.8 (20.3%) 06:13:27 INFO - TinderboxPrint: CPU user
1,638.5 (33.9%) 06:13:27 INFO - TinderboxPrint: Swap in / out
364,601,344 / 0 06:13:27 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 358406656; Write bytes: 356716544; Read time: 27451; Write time: 833 06:13:27 INFO - run-tests - Wall time: 1175s; CPU: 54.0%; Read bytes: 720896; Write bytes: 299644928; Read time: 8; Write time: 1289 06:13:28 INFO - Running post-run listener: _upload_blobber_files 06:13:28 INFO - Blob upload gear active. 06:13:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:13:28 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:13:28 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:13:28 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:13:28 INFO - (blobuploader) - INFO - Open directory for files ... 06:13:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:13:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:13:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:13:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:13:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:13:29 INFO - (blobuploader) - INFO - Done attempting. 06:13:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:13:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:13:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:13:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:13:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:13:30 INFO - (blobuploader) - INFO - Done attempting. 06:13:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:13:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:13:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:13:32 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:13:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:13:32 INFO - (blobuploader) - INFO - Done attempting. 06:13:32 INFO - (blobuploader) - INFO - Iteration through files over. 06:13:32 INFO - Return code: 0 06:13:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:13:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:13:32 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4355b9d5f224176b4393a7381df48c82c1052dced3c752deef75b3182378f6562e3cc91a006366cf524831dd9e866854457c6600b1006ce5c277e9c84109ade7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1f3bd028e21b28bec91abdc401b8560f387ce6fe262552898ee8898cecdeb664bcab69062f60d7c2d39a28bcd92bfe74fb20ba877446dce39b9d4406989c1ec2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8b1eb956de6ff74d15ec4423f308bcd5826d5a8442c306e9ac6c57ef36cced62c6ea0743a4eeffbe2a8ee807382257e7a7c859056cccfaa4d885f4cf8ba7a902"} 06:13:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:13:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:13:32 INFO - Contents: 06:13:32 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4355b9d5f224176b4393a7381df48c82c1052dced3c752deef75b3182378f6562e3cc91a006366cf524831dd9e866854457c6600b1006ce5c277e9c84109ade7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1f3bd028e21b28bec91abdc401b8560f387ce6fe262552898ee8898cecdeb664bcab69062f60d7c2d39a28bcd92bfe74fb20ba877446dce39b9d4406989c1ec2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8b1eb956de6ff74d15ec4423f308bcd5826d5a8442c306e9ac6c57ef36cced62c6ea0743a4eeffbe2a8ee807382257e7a7c859056cccfaa4d885f4cf8ba7a902"} 06:13:32 INFO - Running post-run listener: copy_logs_to_upload_dir 06:13:32 INFO - Copying logs to upload dir... 06:13:32 INFO - mkdir: /builds/slave/test/build/upload/logs 06:13:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.770025 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-11-04 06:13:32.696079) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-04 06:13:32.699638) ========= 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.eMKAMV9gzh/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.ij8uOpdQv5/Listeners TMPDIR=/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4355b9d5f224176b4393a7381df48c82c1052dced3c752deef75b3182378f6562e3cc91a006366cf524831dd9e866854457c6600b1006ce5c277e9c84109ade7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1f3bd028e21b28bec91abdc401b8560f387ce6fe262552898ee8898cecdeb664bcab69062f60d7c2d39a28bcd92bfe74fb20ba877446dce39b9d4406989c1ec2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8b1eb956de6ff74d15ec4423f308bcd5826d5a8442c306e9ac6c57ef36cced62c6ea0743a4eeffbe2a8ee807382257e7a7c859056cccfaa4d885f4cf8ba7a902"} build_url:https://queue.taskcluster.net/v1/task/bem3mmm3QYCTLOOtaNv64g/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011204 build_url: 'https://queue.taskcluster.net/v1/task/bem3mmm3QYCTLOOtaNv64g/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4355b9d5f224176b4393a7381df48c82c1052dced3c752deef75b3182378f6562e3cc91a006366cf524831dd9e866854457c6600b1006ce5c277e9c84109ade7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1f3bd028e21b28bec91abdc401b8560f387ce6fe262552898ee8898cecdeb664bcab69062f60d7c2d39a28bcd92bfe74fb20ba877446dce39b9d4406989c1ec2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8b1eb956de6ff74d15ec4423f308bcd5826d5a8442c306e9ac6c57ef36cced62c6ea0743a4eeffbe2a8ee807382257e7a7c859056cccfaa4d885f4cf8ba7a902"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-04 06:13:32.732494) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-04 06:13:32.732860) ========= 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.eMKAMV9gzh/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.ij8uOpdQv5/Listeners TMPDIR=/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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.005379 ========= master_lag: 0.10 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-04 06:13:32.836431) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-04 06:13:32.836791) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-04 06:13:32.837101) ========= ========= Total master_lag: 0.44 =========