builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0016 starttime: 1476046710.35 results: success (0) buildid: 20161009120418 builduid: de130ea26c6a42cfbade47182c7ce474 revision: 0ba0016683aef98cd7a64ff5e31f23e8d7eb08aa ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-09 13:58:30.349216) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-09 13:58:30.349824) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-09 13:58:30.350569) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-09 13:58:30.658644) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-09 13:58:30.659128) ========= 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.QbhLxyOo7A/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.HA6NdCup4d/Listeners TMPDIR=/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-10-09 13:58:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 154M=0s 2016-10-09 13:58:31 (154 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.595772 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-09 13:58:31.328945) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-09 13:58:31.329280) ========= 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.QbhLxyOo7A/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.HA6NdCup4d/Listeners TMPDIR=/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/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.022060 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-09 13:58:31.392380) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-09 13:58:31.392744) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 0ba0016683aef98cd7a64ff5e31f23e8d7eb08aa --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 0ba0016683aef98cd7a64ff5e31f23e8d7eb08aa --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.QbhLxyOo7A/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.HA6NdCup4d/Listeners TMPDIR=/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-10-09 13:58:31,465 truncating revision to first 12 chars 2016-10-09 13:58:31,465 Setting DEBUG logging. 2016-10-09 13:58:31,465 attempt 1/10 2016-10-09 13:58:31,465 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/0ba0016683ae?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-09 13:58:32,132 unpacking tar archive at: mozilla-central-0ba0016683ae/testing/mozharness/ program finished with exit code 0 elapsedTime=0.951727 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-09 13:58:32.368624) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-09 13:58:32.368984) ========= script_repo_revision: 0ba0016683aef98cd7a64ff5e31f23e8d7eb08aa ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-09 13:58:32.369443) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-09 13:58:32.369749) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-09 13:58:32.387876) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-10-09 13:58:32.388193) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.QbhLxyOo7A/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.HA6NdCup4d/Listeners TMPDIR=/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/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 13:58:32 INFO - MultiFileLogger online at 20161009 13:58:32 in /builds/slave/test 13:58:32 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 13:58:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:58:32 INFO - {'append_to_log': False, 13:58:32 INFO - 'base_work_dir': '/builds/slave/test', 13:58:32 INFO - 'blob_upload_branch': 'Firefox', 13:58:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:58:32 INFO - 'branch': 'Firefox', 13:58:32 INFO - 'buildbot_json_path': 'buildprops.json', 13:58:32 INFO - 'config_files': ('talos/mac_config.py',), 13:58:32 INFO - 'default_actions': ('clobber', 13:58:32 INFO - 'read-buildbot-config', 13:58:32 INFO - 'download-and-extract', 13:58:32 INFO - 'populate-webroot', 13:58:32 INFO - 'create-virtualenv', 13:58:32 INFO - 'install', 13:58:32 INFO - 'run-tests'), 13:58:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:58:32 INFO - 'download_minidump_stackwalk': True, 13:58:32 INFO - 'download_symbols': 'ondemand', 13:58:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:58:32 INFO - 'tooltool.py': '/tools/tooltool.py', 13:58:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:58:32 INFO - '/tools/misc-python/virtualenv.py')}, 13:58:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:58:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:58:32 INFO - 'installer_path': 'installer.exe', 13:58:32 INFO - 'log_level': 'info', 13:58:32 INFO - 'log_name': 'talos', 13:58:32 INFO - 'log_to_console': True, 13:58:32 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:58:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:58:32 INFO - 'opt_config_files': (), 13:58:32 INFO - 'pip_index': False, 13:58:32 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:58:32 INFO - 'cmd': ('bash', 13:58:32 INFO - '-c', 13:58:32 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:58:32 INFO - 'enabled': True, 13:58:32 INFO - 'halt_on_failure': False, 13:58:32 INFO - 'name': 'check_screen_resolution'},), 13:58:32 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:58:32 INFO - 'cmd': ('bash', 13:58:32 INFO - '-c', 13:58:32 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:58:32 INFO - 'enabled': True, 13:58:32 INFO - 'halt_on_failure': False, 13:58:32 INFO - 'name': 'check_screen_resolution'},), 13:58:32 INFO - 'run_cmd_checks_enabled': True, 13:58:32 INFO - 'sps_profile': False, 13:58:32 INFO - 'sps_profile_interval': 0, 13:58:32 INFO - 'suite': 'dromaeojs-e10s', 13:58:32 INFO - 'system_bits': '32', 13:58:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:58:32 INFO - 'title': 't-yosemite-r7-0016', 13:58:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:58:32 INFO - 'use_talos_json': True, 13:58:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:58:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:58:32 INFO - 'work_dir': 'build'} 13:58:32 INFO - [mozharness: 2016-10-09 20:58:32.588494Z] Running clobber step. 13:58:32 INFO - Running pre-action listener: _resource_record_pre_action 13:58:32 INFO - Running main action method: clobber 13:58:32 INFO - rmtree: /builds/slave/test/build 13:58:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:58:34 INFO - Running post-action listener: _resource_record_post_action 13:58:34 INFO - [mozharness: 2016-10-09 20:58:34.216904Z] Finished clobber step (success) 13:58:34 INFO - [mozharness: 2016-10-09 20:58:34.217140Z] Running read-buildbot-config step. 13:58:34 INFO - Running pre-action listener: _resource_record_pre_action 13:58:34 INFO - Running main action method: read_buildbot_config 13:58:34 INFO - Using buildbot properties: 13:58:34 INFO - { 13:58:34 INFO - "project": "", 13:58:34 INFO - "product": "firefox", 13:58:34 INFO - "script_repo_revision": "production", 13:58:34 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 13:58:34 INFO - "repository": "", 13:58:34 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 13:58:34 INFO - "buildid": "20161009120418", 13:58:34 INFO - "pgo_build": "False", 13:58:34 INFO - "basedir": "/builds/slave/test", 13:58:34 INFO - "buildnumber": 16, 13:58:34 INFO - "slavename": "t-yosemite-r7-0016", 13:58:34 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 13:58:34 INFO - "platform": "yosemite_r7", 13:58:34 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 13:58:34 INFO - "branch": "mozilla-central", 13:58:34 INFO - "repo_path": "mozilla-central", 13:58:34 INFO - "revision": "0ba0016683aef98cd7a64ff5e31f23e8d7eb08aa", 13:58:34 INFO - "stage_platform": "macosx64", 13:58:34 INFO - "builduid": "de130ea26c6a42cfbade47182c7ce474", 13:58:34 INFO - "slavebuilddir": "test" 13:58:34 INFO - } 13:58:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/M9pOvnTyRRS0-6QWyPwEvA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 13:58:34 INFO - Running post-action listener: _resource_record_post_action 13:58:34 INFO - [mozharness: 2016-10-09 20:58:34.222482Z] Finished read-buildbot-config step (success) 13:58:34 INFO - [mozharness: 2016-10-09 20:58:34.222668Z] Running download-and-extract step. 13:58:34 INFO - Running pre-action listener: _resource_record_pre_action 13:58:34 INFO - Running main action method: download_and_extract 13:58:34 INFO - mkdir: /builds/slave/test/build/tests 13:58:34 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')]} 13:58:34 INFO - trying https://queue.taskcluster.net/v1/task/M9pOvnTyRRS0-6QWyPwEvA/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 13:58:34 INFO - Downloading https://queue.taskcluster.net/v1/task/M9pOvnTyRRS0-6QWyPwEvA/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 13:58:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/M9pOvnTyRRS0-6QWyPwEvA/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 13:58:35 INFO - Downloaded 1199 bytes. 13:58:35 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 13:58:35 INFO - Using the following test package requirements: 13:58:35 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 13:58:35 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:58:35 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 13:58:35 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:58:35 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 13:58:35 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:58:35 INFO - u'jsshell-mac.zip'], 13:58:35 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:58:35 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 13:58:35 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 13:58:35 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:58:35 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 13:58:35 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:58:35 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 13:58:35 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:58:35 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 13:58:35 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:58:35 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 13:58:35 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 13:58:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/M9pOvnTyRRS0-6QWyPwEvA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 13:58:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/M9pOvnTyRRS0-6QWyPwEvA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 13:58:35 INFO - Fetch https://queue.taskcluster.net/v1/task/M9pOvnTyRRS0-6QWyPwEvA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 13:58:36 INFO - Http code: 200 13:58:36 INFO - via: 1.1 b9a8ce441329f20cea895e08f19f1ec8.cloudfront.net (CloudFront) 13:58:36 INFO - x-amz-cf-id: CP1quTwGJC03aKzx2I4Nj0VRk9rYtxiC4Hnjmn2rcmKAGeaPiPZBDw== 13:58:36 INFO - x-amz-version-id: 7jQRAxARNeCyFnuRZa.AaS5ZedIbhV9N 13:58:36 INFO - Expected file size: 16496335 13:58:36 INFO - Obtained file size: 16496335 13:58:42 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 13:58:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/M9pOvnTyRRS0-6QWyPwEvA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 13:58:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/M9pOvnTyRRS0-6QWyPwEvA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 13:58:42 INFO - Fetch https://queue.taskcluster.net/v1/task/M9pOvnTyRRS0-6QWyPwEvA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 13:58:43 INFO - Http code: 200 13:58:43 INFO - via: 1.1 e30ae5b3d9f6779a9b8bc992faad0b09.cloudfront.net (CloudFront) 13:58:43 INFO - x-amz-cf-id: 8SHmfeIoSZu3OzN1Xl4JJ3PnefCjWUXuMZ096Awoz7FufCM8iRZMiQ== 13:58:43 INFO - x-amz-version-id: 7jQRAxARNeCyFnuRZa.AaS5ZedIbhV9N 13:58:43 INFO - Expected file size: 16496335 13:58:43 INFO - Obtained file size: 16496335 13:58:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/M9pOvnTyRRS0-6QWyPwEvA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 13:58:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/M9pOvnTyRRS0-6QWyPwEvA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 13:58:50 INFO - Fetch https://queue.taskcluster.net/v1/task/M9pOvnTyRRS0-6QWyPwEvA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 13:58:51 INFO - Http code: 200 13:58:51 INFO - via: 1.1 0cf1d7257c633ae75623c5e75bf3805e.cloudfront.net (CloudFront) 13:58:51 INFO - x-amz-cf-id: _euRlWgiS8x4sNpa-UWJye8fdqk86J44tyafgGA6z2aVnwP2gJWz2w== 13:58:51 INFO - x-amz-version-id: b8w1LvpEZpNWaGfXeVR_hLlW2i4vVGMg 13:58:51 INFO - Expected file size: 14409006 13:58:51 INFO - Obtained file size: 14409006 13:58:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:58:51 INFO - trying https://queue.taskcluster.net/v1/task/M9pOvnTyRRS0-6QWyPwEvA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 13:58:51 INFO - Downloading https://queue.taskcluster.net/v1/task/M9pOvnTyRRS0-6QWyPwEvA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 13:58:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/M9pOvnTyRRS0-6QWyPwEvA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 13:58:55 INFO - Downloaded 111710727 bytes. 13:58:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/M9pOvnTyRRS0-6QWyPwEvA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 13:58:55 INFO - mkdir: /builds/slave/test/properties 13:58:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:58:55 INFO - Writing to file /builds/slave/test/properties/build_url 13:58:55 INFO - Contents: 13:58:55 INFO - build_url:https://queue.taskcluster.net/v1/task/M9pOvnTyRRS0-6QWyPwEvA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 13:58:55 INFO - Running post-action listener: _resource_record_post_action 13:58:55 INFO - Running post-action listener: set_extra_try_arguments 13:58:55 INFO - [mozharness: 2016-10-09 20:58:55.857263Z] Finished download-and-extract step (success) 13:58:55 INFO - [mozharness: 2016-10-09 20:58:55.857396Z] Running populate-webroot step. 13:58:55 INFO - Running pre-action listener: _resource_record_pre_action 13:58:55 INFO - Running main action method: populate_webroot 13:58:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:58:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:58:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:58:55 INFO - '--tppagecycles', 13:58:55 INFO - '7'], 13:58:55 INFO - 'tests': ['tsvgm']}}, 13:58:55 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:58:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:58:55 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:58:55 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:58:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:58:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:58:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:58:55 INFO - 'talos_options': ['--disable-e10s'], 13:58:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:58:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:58:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:58:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:58:55 INFO - 'talos_options': ['--disable-e10s'], 13:58:55 INFO - 'tests': ['damp', 'tps']}, 13:58:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:58:55 INFO - 'tests': ['damp', 'tps']}, 13:58:55 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:58:55 INFO - 'tests': ['dromaeo_dom']}, 13:58:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:58:55 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:58:55 INFO - 'tests': ['basic_compositor_video']}, 13:58:55 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:58:55 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:58:55 INFO - 'tests': ['a11yr', 13:58:55 INFO - 'ts_paint', 13:58:55 INFO - 'tpaint', 13:58:55 INFO - 'sessionrestore', 13:58:55 INFO - 'sessionrestore_no_auto_restore', 13:58:55 INFO - 'tabpaint']}, 13:58:55 INFO - 'other-e10s': {'tests': ['a11yr', 13:58:55 INFO - 'ts_paint', 13:58:55 INFO - 'tpaint', 13:58:55 INFO - 'sessionrestore', 13:58:55 INFO - 'sessionrestore_no_auto_restore', 13:58:55 INFO - 'tabpaint']}, 13:58:55 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:58:55 INFO - 'ts_paint', 13:58:55 INFO - 'tpaint', 13:58:55 INFO - 'sessionrestore', 13:58:55 INFO - 'sessionrestore_no_auto_restore', 13:58:55 INFO - 'tabpaint']}, 13:58:55 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:58:55 INFO - 'ts_paint', 13:58:55 INFO - 'tpaint', 13:58:55 INFO - 'sessionrestore', 13:58:55 INFO - 'sessionrestore_no_auto_restore', 13:58:55 INFO - 'tabpaint']}, 13:58:55 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:58:55 INFO - 'tests': ['a11yr', 13:58:55 INFO - 'ts_paint', 13:58:55 INFO - 'tpaint', 13:58:55 INFO - 'sessionrestore', 13:58:55 INFO - 'sessionrestore_no_auto_restore', 13:58:55 INFO - 'tabpaint']}, 13:58:55 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:58:55 INFO - 'tests': ['a11yr', 13:58:55 INFO - 'ts_paint', 13:58:55 INFO - 'tpaint', 13:58:55 INFO - 'sessionrestore', 13:58:55 INFO - 'sessionrestore_no_auto_restore', 13:58:55 INFO - 'tabpaint']}, 13:58:55 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:58:55 INFO - 'tests': ['tsvgx', 13:58:55 INFO - 'tsvgr_opacity', 13:58:55 INFO - 'tart', 13:58:55 INFO - 'tscrollx', 13:58:55 INFO - 'cart']}, 13:58:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:58:55 INFO - 'tsvgr_opacity', 13:58:55 INFO - 'tart', 13:58:55 INFO - 'tscrollx', 13:58:55 INFO - 'cart']}, 13:58:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:58:55 INFO - 'talos_options': ['--disable-e10s'], 13:58:55 INFO - 'tests': ['tp5o']}, 13:58:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:58:55 INFO - 'tests': ['tp5o']}, 13:58:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:58:55 INFO - 'talos_options': ['--disable-e10s', 13:58:55 INFO - '--xperf_path', 13:58:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:58:55 INFO - 'tests': ['tp5n']}, 13:58:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:58:55 INFO - 'talos_options': ['--xperf_path', 13:58:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:58:55 INFO - 'tests': ['tp5n']}}, 13:58:55 INFO - 'talos.zip': {'path': '', 13:58:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:58:55 INFO - Running post-action listener: _resource_record_post_action 13:58:55 INFO - [mozharness: 2016-10-09 20:58:55.875960Z] Finished populate-webroot step (success) 13:58:55 INFO - [mozharness: 2016-10-09 20:58:55.876071Z] Running create-virtualenv step. 13:58:55 INFO - Running pre-action listener: _resource_record_pre_action 13:58:55 INFO - Running main action method: create_virtualenv 13:58:55 INFO - Creating virtualenv /builds/slave/test/build/venv 13:58:55 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 13:58:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:58:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:58:55 INFO - Using real prefix '/tools/python27' 13:58:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:58:56 INFO - Installing distribute.............................................................................................................................................................................................done. 13:58:59 INFO - Installing pip.................done. 13:58:59 INFO - Return code: 0 13:58:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:58:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:58:59 INFO - Reading from file tmpfile_stdout 13:58:59 INFO - Output received: 13:58:59 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 13:58:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:58:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:58:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:58:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:58:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:58:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109ead490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e23570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc052c7e7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109cc1d30>, '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 0x109ae7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109cb9b20>, '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.QbhLxyOo7A/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.HA6NdCup4d/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/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 13:58:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 13:58:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:58:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QbhLxyOo7A/Render', 13:58:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:58:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:58:59 INFO - 'HOME': '/Users/cltbld', 13:58:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:58:59 INFO - 'LOGNAME': 'cltbld', 13:58:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:58:59 INFO - 'MOZ_NO_REMOTE': '1', 13:58:59 INFO - 'NO_EM_RESTART': '1', 13:58:59 INFO - 'PAGER': '/bin/cat', 13:58:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:58:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:58:59 INFO - 'PWD': '/builds/slave/test', 13:58:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:58:59 INFO - 'SHELL': '/bin/bash', 13:58:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HA6NdCup4d/Listeners', 13:58:59 INFO - 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/', 13:58:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:58:59 INFO - 'USER': 'cltbld', 13:58:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:58:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:58:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:58:59 INFO - 'XPC_FLAGS': '0x0', 13:58:59 INFO - 'XPC_SERVICE_NAME': '0', 13:58:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:59:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:59:00 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 13:59:00 INFO - Cleaning up... 13:59:00 INFO - Return code: 0 13:59:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:59: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')]} 13:59:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:59:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59: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')]} 13:59:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:59:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59: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', '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 0x109ead490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e23570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc052c7e7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109cc1d30>, '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 0x109ae7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109cb9b20>, '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.QbhLxyOo7A/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.HA6NdCup4d/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/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 13:59: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', 'psutil>=3.1.1'] in /builds/slave/test/build 13:59: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 psutil>=3.1.1 13:59:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QbhLxyOo7A/Render', 13:59:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:59:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:59:00 INFO - 'HOME': '/Users/cltbld', 13:59:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:59:00 INFO - 'LOGNAME': 'cltbld', 13:59:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:59:00 INFO - 'MOZ_NO_REMOTE': '1', 13:59:00 INFO - 'NO_EM_RESTART': '1', 13:59:00 INFO - 'PAGER': '/bin/cat', 13:59:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:59:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:59:00 INFO - 'PWD': '/builds/slave/test', 13:59:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:59:00 INFO - 'SHELL': '/bin/bash', 13:59:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HA6NdCup4d/Listeners', 13:59:00 INFO - 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/', 13:59:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:59:00 INFO - 'USER': 'cltbld', 13:59:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:59:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:59:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:59:00 INFO - 'XPC_FLAGS': '0x0', 13:59:00 INFO - 'XPC_SERVICE_NAME': '0', 13:59:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:59:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:59:00 INFO - Downloading/unpacking psutil>=3.1.1 13:59:00 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 13:59:00 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 13:59:00 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 13:59:00 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 13:59:00 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 13:59:00 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 13:59:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:59:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:59:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:59:04 INFO - Installing collected packages: psutil 13:59:04 INFO - Running setup.py install for psutil 13:59:04 INFO - building 'psutil._psutil_osx' extension 13:59:04 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 13:59:04 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 13:59:04 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 13:59:04 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 13:59:04 INFO - building 'psutil._psutil_posix' extension 13:59:04 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 13:59:04 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:59:04 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:59:04 INFO - ^ 13:59:04 INFO - 1 warning generated. 13:59:04 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 13:59:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:59:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:59:05 INFO - Successfully installed psutil 13:59:05 INFO - Cleaning up... 13:59:05 INFO - Return code: 0 13:59:05 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:59:05 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')]} 13:59:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:59:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:05 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')]} 13:59:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:59:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:05 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 0x109ead490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e23570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc052c7e7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109cc1d30>, '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 0x109ae7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109cb9b20>, '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.QbhLxyOo7A/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.HA6NdCup4d/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/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 13:59:05 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 13:59:05 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 13:59:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QbhLxyOo7A/Render', 13:59:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:59:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:59:05 INFO - 'HOME': '/Users/cltbld', 13:59:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:59:05 INFO - 'LOGNAME': 'cltbld', 13:59:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:59:05 INFO - 'MOZ_NO_REMOTE': '1', 13:59:05 INFO - 'NO_EM_RESTART': '1', 13:59:05 INFO - 'PAGER': '/bin/cat', 13:59:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:59:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:59:05 INFO - 'PWD': '/builds/slave/test', 13:59:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:59:05 INFO - 'SHELL': '/bin/bash', 13:59:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HA6NdCup4d/Listeners', 13:59:05 INFO - 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/', 13:59:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:59:05 INFO - 'USER': 'cltbld', 13:59:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:59:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:59:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:59:05 INFO - 'XPC_FLAGS': '0x0', 13:59:05 INFO - 'XPC_SERVICE_NAME': '0', 13:59:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:59:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:59:05 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:59: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 13:59: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 13:59: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 13:59: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 13:59: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 13:59: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 13:59:07 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:59:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:59:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:59:08 INFO - Installing collected packages: mozsystemmonitor 13:59:08 INFO - Running setup.py install for mozsystemmonitor 13:59:08 INFO - Successfully installed mozsystemmonitor 13:59:08 INFO - Cleaning up... 13:59:08 INFO - Return code: 0 13:59:08 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:59:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:59:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:59:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:59:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:59:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x109ead490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e23570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc052c7e7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109cc1d30>, '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 0x109ae7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109cb9b20>, '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.QbhLxyOo7A/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.HA6NdCup4d/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/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 13:59:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 13:59:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 13:59:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QbhLxyOo7A/Render', 13:59:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:59:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:59:08 INFO - 'HOME': '/Users/cltbld', 13:59:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:59:08 INFO - 'LOGNAME': 'cltbld', 13:59:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:59:08 INFO - 'MOZ_NO_REMOTE': '1', 13:59:08 INFO - 'NO_EM_RESTART': '1', 13:59:08 INFO - 'PAGER': '/bin/cat', 13:59:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:59:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:59:08 INFO - 'PWD': '/builds/slave/test', 13:59:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:59:08 INFO - 'SHELL': '/bin/bash', 13:59:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HA6NdCup4d/Listeners', 13:59:08 INFO - 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/', 13:59:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:59:08 INFO - 'USER': 'cltbld', 13:59:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:59:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:59:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:59:08 INFO - 'XPC_FLAGS': '0x0', 13:59:08 INFO - 'XPC_SERVICE_NAME': '0', 13:59:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:59:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:59:08 INFO - Downloading/unpacking jsonschema==2.5.1 13:59: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 13:59: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 13:59: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 13:59: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 13:59: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 13:59: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 13:59:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:59:10 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:59:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:59:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:59:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:59:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:59:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:59:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:59:11 INFO - Downloading functools32-3.2.3-2.tar.gz 13:59:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:59:11 INFO - warning: no files found matching '*.txt' 13:59:11 INFO - no previously-included directories found matching 'build' 13:59:11 INFO - no previously-included directories found matching 'dist' 13:59:11 INFO - no previously-included directories found matching '.git*' 13:59:11 INFO - Installing collected packages: jsonschema, functools32 13:59:11 INFO - Running setup.py install for functools32 13:59:11 INFO - warning: no files found matching '*.txt' 13:59:11 INFO - no previously-included directories found matching 'build' 13:59:11 INFO - no previously-included directories found matching 'dist' 13:59:11 INFO - no previously-included directories found matching '.git*' 13:59:11 INFO - Successfully installed jsonschema functools32 13:59:11 INFO - Cleaning up... 13:59:11 INFO - Return code: 0 13:59:11 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:59:11 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')]} 13:59:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:59:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:11 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')]} 13:59:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:59:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:11 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 0x109ead490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e23570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc052c7e7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109cc1d30>, '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 0x109ae7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109cb9b20>, '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.QbhLxyOo7A/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.HA6NdCup4d/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/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 13:59:11 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 13:59:11 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 13:59:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QbhLxyOo7A/Render', 13:59:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:59:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:59:11 INFO - 'HOME': '/Users/cltbld', 13:59:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:59:11 INFO - 'LOGNAME': 'cltbld', 13:59:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:59:11 INFO - 'MOZ_NO_REMOTE': '1', 13:59:11 INFO - 'NO_EM_RESTART': '1', 13:59:11 INFO - 'PAGER': '/bin/cat', 13:59:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:59:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:59:11 INFO - 'PWD': '/builds/slave/test', 13:59:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:59:11 INFO - 'SHELL': '/bin/bash', 13:59:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HA6NdCup4d/Listeners', 13:59:11 INFO - 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/', 13:59:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:59:11 INFO - 'USER': 'cltbld', 13:59:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:59:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:59:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:59:11 INFO - 'XPC_FLAGS': '0x0', 13:59:11 INFO - 'XPC_SERVICE_NAME': '0', 13:59:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:59:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:59:12 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:59:12 INFO - Cleaning up... 13:59:12 INFO - Return code: 0 13:59:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:59:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:59:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:59:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:59:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:59:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:12 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 0x109ead490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e23570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc052c7e7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109cc1d30>, '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 0x109ae7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109cb9b20>, '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.QbhLxyOo7A/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.HA6NdCup4d/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/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 13:59:12 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 13:59:12 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 13:59:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QbhLxyOo7A/Render', 13:59:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:59:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:59:12 INFO - 'HOME': '/Users/cltbld', 13:59:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:59:12 INFO - 'LOGNAME': 'cltbld', 13:59:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:59:12 INFO - 'MOZ_NO_REMOTE': '1', 13:59:12 INFO - 'NO_EM_RESTART': '1', 13:59:12 INFO - 'PAGER': '/bin/cat', 13:59:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:59:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:59:12 INFO - 'PWD': '/builds/slave/test', 13:59:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:59:12 INFO - 'SHELL': '/bin/bash', 13:59:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HA6NdCup4d/Listeners', 13:59:12 INFO - 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/', 13:59:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:59:12 INFO - 'USER': 'cltbld', 13:59:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:59:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:59:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:59:12 INFO - 'XPC_FLAGS': '0x0', 13:59:12 INFO - 'XPC_SERVICE_NAME': '0', 13:59:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:59:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:59:12 INFO - Downloading/unpacking blobuploader==1.2.4 13:59:12 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 13:59:12 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 13:59:12 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 13:59:12 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 13:59:12 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 13:59:12 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 13:59:14 INFO - Downloading blobuploader-1.2.4.tar.gz 13:59:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:59:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:59:14 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 13:59:14 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 13:59:14 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 13:59:14 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 13:59:14 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 13:59:14 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 13:59:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:59:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:59:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:59:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:59:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:59:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:59:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:59:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:59:15 INFO - Downloading docopt-0.6.1.tar.gz 13:59:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:59:16 INFO - Installing collected packages: blobuploader, requests, docopt 13:59:16 INFO - Running setup.py install for blobuploader 13:59:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:59:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:59:16 INFO - Running setup.py install for requests 13:59:16 INFO - Running setup.py install for docopt 13:59:16 INFO - Successfully installed blobuploader requests docopt 13:59:16 INFO - Cleaning up... 13:59:16 INFO - Return code: 0 13:59:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:59:16 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')]} 13:59:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:59:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:16 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')]} 13:59:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:59:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:16 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 0x109ead490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e23570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc052c7e7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109cc1d30>, '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 0x109ae7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109cb9b20>, '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.QbhLxyOo7A/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.HA6NdCup4d/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/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 13:59:16 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 13:59:16 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 13:59:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QbhLxyOo7A/Render', 13:59:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:59:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:59:16 INFO - 'HOME': '/Users/cltbld', 13:59:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:59:16 INFO - 'LOGNAME': 'cltbld', 13:59:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:59:16 INFO - 'MOZ_NO_REMOTE': '1', 13:59:16 INFO - 'NO_EM_RESTART': '1', 13:59:16 INFO - 'PAGER': '/bin/cat', 13:59:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:59:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:59:16 INFO - 'PWD': '/builds/slave/test', 13:59:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:59:16 INFO - 'SHELL': '/bin/bash', 13:59:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HA6NdCup4d/Listeners', 13:59:16 INFO - 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/', 13:59:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:59:16 INFO - 'USER': 'cltbld', 13:59:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:59:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:59:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:59:16 INFO - 'XPC_FLAGS': '0x0', 13:59:16 INFO - 'XPC_SERVICE_NAME': '0', 13:59:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:59:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:59:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:59:17 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-V6ve3E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:59:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:59:17 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-ry89CA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:59:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:59:17 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-bEarer-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:59:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:59:17 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-wjJZmy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:59:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:59:17 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-qhBUKz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:59:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:59:17 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-uBBDt1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:59:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:59:17 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-pbKTnL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:59:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:59:17 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-YnlUaq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:59:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:59:17 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-6vDDmv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:59:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:59:18 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-anEEJC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:59:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:59:18 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-6FFff8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:59:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:59:18 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-cKo0e8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:59:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:59:18 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-jjeRO0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:59:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:59:18 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-huyfLP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:59:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:59:18 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-U3_D0A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:59:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:59:18 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-LHo7nB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:59:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:59:18 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-JQypN5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:59:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:59:18 INFO - Running setup.py install for manifestparser 13:59:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:59:19 INFO - Running setup.py install for mozcrash 13:59:19 INFO - Running setup.py install for mozdebug 13:59:19 INFO - Running setup.py install for mozdevice 13:59:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:59:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:59:19 INFO - Running setup.py install for mozfile 13:59:19 INFO - Running setup.py install for mozhttpd 13:59:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:59:19 INFO - Running setup.py install for mozinfo 13:59:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:59:19 INFO - Running setup.py install for mozInstall 13:59:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:59:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:59:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:59:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:59:20 INFO - Running setup.py install for mozleak 13:59:20 INFO - Running setup.py install for mozlog 13:59:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:59:20 INFO - Running setup.py install for moznetwork 13:59:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:59:20 INFO - Running setup.py install for mozprocess 13:59:20 INFO - Running setup.py install for mozprofile 13:59:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:59:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:59:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:59:20 INFO - Running setup.py install for mozrunner 13:59:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:59:21 INFO - Running setup.py install for mozscreenshot 13:59:21 INFO - Running setup.py install for moztest 13:59:21 INFO - Running setup.py install for mozversion 13:59:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:59:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:59:21 INFO - Cleaning up... 13:59:21 INFO - Return code: 0 13:59:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:59:21 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')]} 13:59:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:59:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:21 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')]} 13:59:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:59:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:21 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 0x109ead490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e23570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc052c7e7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109cc1d30>, '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 0x109ae7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109cb9b20>, '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.QbhLxyOo7A/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.HA6NdCup4d/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/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 13:59:21 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 13:59:21 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 13:59:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QbhLxyOo7A/Render', 13:59:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:59:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:59:21 INFO - 'HOME': '/Users/cltbld', 13:59:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:59:21 INFO - 'LOGNAME': 'cltbld', 13:59:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:59:21 INFO - 'MOZ_NO_REMOTE': '1', 13:59:21 INFO - 'NO_EM_RESTART': '1', 13:59:21 INFO - 'PAGER': '/bin/cat', 13:59:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:59:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:59:21 INFO - 'PWD': '/builds/slave/test', 13:59:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:59:21 INFO - 'SHELL': '/bin/bash', 13:59:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HA6NdCup4d/Listeners', 13:59:21 INFO - 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/', 13:59:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:59:21 INFO - 'USER': 'cltbld', 13:59:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:59:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:59:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:59:21 INFO - 'XPC_FLAGS': '0x0', 13:59:21 INFO - 'XPC_SERVICE_NAME': '0', 13:59:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:59:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:59:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:59:21 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-hoBY2V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:59:21 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)) 13:59:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:59:21 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-t2HETK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:59:22 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)) 13:59:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:59:22 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-lipsFo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:59:22 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)) 13:59:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:59:22 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-FgA9Uf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:59:22 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)) 13:59:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:59:22 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-jm4oQD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:59:22 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)) 13:59:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:59:22 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-ehNT5h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:59:22 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)) 13:59:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:59:22 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-DtrlaY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:59:22 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)) 13:59:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:59:22 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-1PMqpT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:59:22 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)) 13:59:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:59:22 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-BV6UnV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:59:22 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)) 13:59:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:59:22 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-7E3uhb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:59:22 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)) 13:59:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:59:22 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-6mOVgy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:59:22 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)) 13:59:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:59:22 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-J2zltf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:59:23 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)) 13:59:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:59:23 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-lci4YA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:59:23 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)) 13:59:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:59:23 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-FQC2VW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:59:23 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)) 13:59:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:59:23 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-vI5I0r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:59:23 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)) 13:59:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:59:23 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-PlhVUu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:59:23 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)) 13:59:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:59:23 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-G49LOy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:59:23 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)) 13:59:23 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)) 13:59:23 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)) 13:59:23 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)) 13:59:23 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)) 13:59:23 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)) 13:59:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:59:23 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 13:59:23 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 13:59:23 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 13:59:23 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 13:59:23 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 13:59:23 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 13:59:26 INFO - Downloading blessings-1.6.tar.gz 13:59:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:59:26 INFO - Installing collected packages: blessings 13:59:26 INFO - Running setup.py install for blessings 13:59:26 INFO - Successfully installed blessings 13:59:26 INFO - Cleaning up... 13:59:26 INFO - Return code: 0 13:59:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:59:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:59:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:59:26 INFO - Reading from file tmpfile_stdout 13:59:26 INFO - Current package versions: 13:59:26 INFO - blessings == 1.6 13:59:26 INFO - blobuploader == 1.2.4 13:59:26 INFO - docopt == 0.6.1 13:59:26 INFO - functools32 == 3.2.3-2 13:59:26 INFO - jsonschema == 2.5.1 13:59:26 INFO - manifestparser == 1.1 13:59:26 INFO - mozInstall == 1.12 13:59:26 INFO - mozcrash == 0.17 13:59:26 INFO - mozdebug == 0.1 13:59:26 INFO - mozdevice == 0.48 13:59:26 INFO - mozfile == 1.2 13:59:26 INFO - mozhttpd == 0.7 13:59:26 INFO - mozinfo == 0.9 13:59:26 INFO - mozleak == 0.1 13:59:26 INFO - mozlog == 3.4 13:59:26 INFO - moznetwork == 0.27 13:59:26 INFO - mozprocess == 0.23 13:59:26 INFO - mozprofile == 0.28 13:59:26 INFO - mozrunner == 6.12 13:59:26 INFO - mozscreenshot == 0.1 13:59:26 INFO - mozsystemmonitor == 0.3 13:59:26 INFO - moztest == 0.7 13:59:26 INFO - mozversion == 1.4 13:59:26 INFO - psutil == 3.1.1 13:59:26 INFO - requests == 1.2.3 13:59:26 INFO - wsgiref == 0.1.2 13:59:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:59:26 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')]} 13:59:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:59:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:26 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')]} 13:59:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:59:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:26 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 0x109ead490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e23570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc052c7e7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109cc1d30>, '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 0x109ae7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109cb9b20>, '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.QbhLxyOo7A/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.HA6NdCup4d/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/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 13:59:26 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 13:59:26 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 13:59:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QbhLxyOo7A/Render', 13:59:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:59:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:59:26 INFO - 'HOME': '/Users/cltbld', 13:59:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:59:26 INFO - 'LOGNAME': 'cltbld', 13:59:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:59:26 INFO - 'MOZ_NO_REMOTE': '1', 13:59:26 INFO - 'NO_EM_RESTART': '1', 13:59:26 INFO - 'PAGER': '/bin/cat', 13:59:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:59:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:59:26 INFO - 'PWD': '/builds/slave/test', 13:59:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:59:26 INFO - 'SHELL': '/bin/bash', 13:59:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HA6NdCup4d/Listeners', 13:59:26 INFO - 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/', 13:59:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:59:26 INFO - 'USER': 'cltbld', 13:59:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:59:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:59:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:59:26 INFO - 'XPC_FLAGS': '0x0', 13:59:26 INFO - 'XPC_SERVICE_NAME': '0', 13:59:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:59:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:59:26 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)) 13:59:26 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)) 13:59:26 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)) 13:59:26 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)) 13:59:26 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)) 13:59:26 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)) 13:59:26 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)) 13:59:26 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)) 13:59:26 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)) 13:59:26 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)) 13:59:26 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)) 13:59:26 INFO - Cleaning up... 13:59:27 INFO - Return code: 0 13:59:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:59:27 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')]} 13:59:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:59:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:27 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')]} 13:59:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:59:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:27 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 0x109ead490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e23570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc052c7e7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109cc1d30>, '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 0x109ae7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109cb9b20>, '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.QbhLxyOo7A/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.HA6NdCup4d/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/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 13:59:27 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 13:59:27 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 13:59:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QbhLxyOo7A/Render', 13:59:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:59:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:59:27 INFO - 'HOME': '/Users/cltbld', 13:59:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:59:27 INFO - 'LOGNAME': 'cltbld', 13:59:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:59:27 INFO - 'MOZ_NO_REMOTE': '1', 13:59:27 INFO - 'NO_EM_RESTART': '1', 13:59:27 INFO - 'PAGER': '/bin/cat', 13:59:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:59:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:59:27 INFO - 'PWD': '/builds/slave/test', 13:59:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:59:27 INFO - 'SHELL': '/bin/bash', 13:59:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HA6NdCup4d/Listeners', 13:59:27 INFO - 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/', 13:59:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:59:27 INFO - 'USER': 'cltbld', 13:59:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:59:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:59:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:59:27 INFO - 'XPC_FLAGS': '0x0', 13:59:27 INFO - 'XPC_SERVICE_NAME': '0', 13:59:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:59:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:59:27 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:59:27 INFO - Cleaning up... 13:59:27 INFO - Return code: 0 13:59:27 INFO - Running post-action listener: _resource_record_post_action 13:59:27 INFO - Running post-action listener: _start_resource_monitoring 13:59:27 INFO - Starting resource monitoring. 13:59:27 INFO - [mozharness: 2016-10-09 20:59:27.306045Z] Finished create-virtualenv step (success) 13:59:27 INFO - [mozharness: 2016-10-09 20:59:27.307057Z] Running install step. 13:59:27 INFO - Running pre-action listener: _resource_record_pre_action 13:59:27 INFO - Running main action method: install 13:59:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:59:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:59:27 INFO - Reading from file tmpfile_stdout 13:59:27 INFO - Detecting whether we're running mozinstall >=1.0... 13:59:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:59:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:59:27 INFO - Reading from file tmpfile_stdout 13:59:27 INFO - Output received: 13:59:27 INFO - Usage: mozinstall [options] installer 13:59:27 INFO - Options: 13:59:27 INFO - -h, --help show this help message and exit 13:59:27 INFO - -d DEST, --destination=DEST 13:59:27 INFO - Directory to install application into. [default: 13:59:27 INFO - "/builds/slave/test"] 13:59:27 INFO - --app=APP Application being installed. [default: firefox] 13:59:27 INFO - mkdir: /builds/slave/test/build/application 13:59:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 13:59:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 14:00:02 INFO - Reading from file tmpfile_stdout 14:00:02 INFO - Output received: 14:00:02 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 14:00:02 INFO - Running post-action listener: _resource_record_post_action 14:00:02 INFO - [mozharness: 2016-10-09 21:00:02.012111Z] Finished install step (success) 14:00:02 INFO - [mozharness: 2016-10-09 21:00:02.012253Z] Running run-tests step. 14:00:02 INFO - Running pre-action listener: _resource_record_pre_action 14:00:02 INFO - Running main action method: run_tests 14:00:02 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:00:02 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:00:02 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:00:02 INFO - 2016-10-09 14:00:02.026 screenresolution[2040:34303] starting screenresolution argv=screenresolution get 14:00:02 INFO - 2016-10-09 14:00:02.029 screenresolution[2040:34303] Display 0: 1600x1200x32@60 14:00:02 INFO - 2016-10-09 14:00:02.035 screenresolution[2041:34305] starting screenresolution argv=screenresolution list 14:00:02 INFO - Available Modes on Display 0 14:00:02 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:00:02 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:00:02 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:00:02 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:00:02 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:00:02 INFO - Intel Iris: 14:00:02 INFO - Chipset Model: Intel Iris 14:00:02 INFO - Type: GPU 14:00:02 INFO - Bus: Built-In 14:00:02 INFO - VRAM (Dynamic, Max): 1536 MB 14:00:02 INFO - Vendor: Intel (0x8086) 14:00:02 INFO - Device ID: 0x0a2e 14:00:02 INFO - Revision ID: 0x0009 14:00:02 INFO - Displays: 14:00:02 INFO - Display: 14:00:02 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:00:02 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:00:02 INFO - Display Serial Number: 1600x1200 60 14:00:02 INFO - Main Display: Yes 14:00:02 INFO - Mirror: Off 14:00:02 INFO - Online: Yes 14:00:02 INFO - Rotation: Supported 14:00:02 INFO - Return code: 0 14:00:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:00:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:00:02 INFO - Python 2.7.3 14:00:02 INFO - Return code: 0 14:00:02 INFO - grabbing minidump binary from tooltool 14:00:02 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')]} 14:00:02 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 0x109cc1d30>, '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 0x109ae7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109cb9b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:00:02 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 14:00:02 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 14:00:02 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 14:00:02 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:00:02 INFO - Return code: 0 14:00:02 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:00:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:00:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:00:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:00:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:00:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/M9pOvnTyRRS0-6QWyPwEvA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0016', '--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 14:00:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/M9pOvnTyRRS0-6QWyPwEvA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0016 --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 14:00:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QbhLxyOo7A/Render', 14:00:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:00:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:00:02 INFO - 'HOME': '/Users/cltbld', 14:00:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:00:02 INFO - 'LOGNAME': 'cltbld', 14:00:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:00:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:00:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:00:02 INFO - 'MOZ_NO_REMOTE': '1', 14:00:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:00:02 INFO - 'NO_EM_RESTART': '1', 14:00:02 INFO - 'PAGER': '/bin/cat', 14:00:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:00:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:00:02 INFO - 'PWD': '/builds/slave/test', 14:00:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:00:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:00:02 INFO - 'SHELL': '/bin/bash', 14:00:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HA6NdCup4d/Listeners', 14:00:02 INFO - 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/', 14:00:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:00:02 INFO - 'USER': 'cltbld', 14:00:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:00:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:00:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:00:02 INFO - 'XPC_FLAGS': '0x0', 14:00:02 INFO - 'XPC_SERVICE_NAME': '0', 14:00:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:00:02 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/M9pOvnTyRRS0-6QWyPwEvA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0016', '--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 14:00:02 INFO - mozversion application_buildid: 20161009120418 14:00:02 INFO - mozversion application_changeset: 0ba0016683aef98cd7a64ff5e31f23e8d7eb08aa 14:00:02 INFO - mozversion application_display_name: Nightly 14:00:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:00:02 INFO - mozversion application_name: Firefox 14:00:02 INFO - mozversion application_remotingname: firefox 14:00:02 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 14:00:02 INFO - mozversion application_vendor: Mozilla 14:00:02 INFO - mozversion application_version: 52.0a1 14:00:02 INFO - mozversion platform_buildid: 20161009120418 14:00:02 INFO - mozversion platform_changeset: 0ba0016683aef98cd7a64ff5e31f23e8d7eb08aa 14:00:02 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 14:00:02 INFO - mozversion platform_version: 52.0a1 14:00:02 INFO - using testdate: 1476046802 14:00:02 INFO - actual date: 1476046802 14:00:02 INFO - starting webserver on 'localhost:52495' 14:00:02 INFO - SUITE-START | Running 2 tests 14:00:02 INFO - TEST-START | dromaeo_css 14:00:02 INFO - operating with platform_type : mac_ 14:00:02 INFO - Initialising browser for dromaeo_css test... 14:00:02 INFO - TEST-INFO | started process 2051 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/tmpwMQ_j0/profile http://localhost:52495/getInfo.html) 14:00:05 INFO - PROCESS | 2051 | 2016-10-09 14:00:05.217 plugin-container[2053:34466] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4c4f, name = 'com.apple.tsm.portname' 14:00:05 INFO - PROCESS | 2051 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:00:05 INFO - PROCESS | 2051 | 2016-10-09 14:00:05.220 plugin-container[2053:34466] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x920b, name = 'com.apple.CFPasteboardClient' 14:00:05 INFO - PROCESS | 2051 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:00:05 INFO - PROCESS | 2051 | 2016-10-09 14:00:05.220 plugin-container[2053:34466] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:00:05 INFO - PROCESS | 2051 | __metrics Screen width/height:1600/1200 14:00:05 INFO - PROCESS | 2051 | colorDepth:24 14:00:05 INFO - PROCESS | 2051 | Browser inner width/height: 1024/689 14:00:05 INFO - PROCESS | 2051 | __metrics 14:00:05 ERROR - PROCESS | 2051 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3083: TypeError: this.tabs is undefined 14:00:06 INFO - TEST-INFO | 2051: exit 0 14:00:06 INFO - Browser initialized. 14:00:06 INFO - Running cycle 1/1 for dromaeo_css test... 14:00:06 INFO - TEST-INFO | started process 2054 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/tmpwMQ_j0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:00:08 INFO - PROCESS | 2054 | 2016-10-09 14:00:08.319 plugin-container[2055:34585] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x471b, name = 'com.apple.tsm.portname' 14:00:08 INFO - PROCESS | 2054 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:00:08 INFO - PROCESS | 2054 | 2016-10-09 14:00:08.321 plugin-container[2055:34585] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9003, name = 'com.apple.CFPasteboardClient' 14:00:08 INFO - PROCESS | 2054 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:00:08 INFO - PROCESS | 2054 | 2016-10-09 14:00:08.321 plugin-container[2055:34585] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:00:18 INFO - PROCESS | 2054 | RSS: Main: 239374336 14:00:18 INFO - PROCESS | 2054 | 14:01:07 INFO - PROCESS | 2054 | 1476046867681 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] 14:03:20 INFO - PROCESS | 2054 | Cycle 1(1): loaded http://localhost:52495/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52495/tests/dromaeo/cssquery-ext.html) 14:03:22 INFO - PROCESS | 2054 | RSS: Main: 250949632 14:03:22 INFO - PROCESS | 2054 | 14:06:24 INFO - PROCESS | 2054 | Cycle 1(1): loaded http://localhost:52495/tests/dromaeo/cssquery-ext.html (next: http://localhost:52495/tests/dromaeo/cssquery-jquery.html) 14:06:25 INFO - PROCESS | 2054 | RSS: Main: 264933376 14:06:25 INFO - PROCESS | 2054 | 14:09:27 INFO - PROCESS | 2054 | Cycle 1(1): loaded http://localhost:52495/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52495/tests/dromaeo/cssquery-mootools.html) 14:09:27 INFO - PROCESS | 2054 | RSS: Main: 269529088 14:09:27 INFO - PROCESS | 2054 | 14:12:29 INFO - PROCESS | 2054 | Cycle 1(1): loaded http://localhost:52495/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52495/tests/dromaeo/cssquery-prototype.html) 14:12:30 INFO - PROCESS | 2054 | RSS: Main: 269377536 14:12:30 INFO - PROCESS | 2054 | 14:15:33 INFO - PROCESS | 2054 | Cycle 1(1): loaded http://localhost:52495/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52495/tests/dromaeo/cssquery-yui.html) 14:15:34 INFO - PROCESS | 2054 | RSS: Main: 274808832 14:15:34 INFO - PROCESS | 2054 | 14:18:36 INFO - PROCESS | 2054 | Cycle 1(1): loaded http://localhost:52495/tests/dromaeo/cssquery-yui.html (next: http://localhost:52495/tests/dromaeo/cssquery-dojo.html) 14:18:37 INFO - PROCESS | 2054 | RSS: Main: 277479424 14:18:37 INFO - PROCESS | 2054 | 14:18:37 INFO - PROCESS | 2054 | __start_tp_report 14:18:37 INFO - PROCESS | 2054 | _x_x_mozilla_page_load 14:18:37 INFO - PROCESS | 2054 | _x_x_mozilla_page_load_details 14:18:37 INFO - PROCESS | 2054 | |i|pagename|runs| 14:18:37 INFO - PROCESS | 2054 | |0;dojo.html;2911.9272018199554;3360.7815491993024;3375.4093033719078;3405.982970085149;3424.948625770613;5702.315722113352;5799.681017544039;5812.796552120672;5813.767449302033;5818.272715910506;5763.740631671574;5825.621334613258;5885.735141918613;5891;5954.821355359335;5241.109011468059;5272.710000949946;5273.841784746454;5389.973050134744;5402.297701298845;5401.4868587484125;5411.621186516945;5419.349678038641;5442.755076021588;5442.945570544303;4340.761258130801;5225.242339860737;5225.581953443753;5231.921521177185;5260.579153667697;4080.6123418275515;5262.552683021948;5276.34045744282;5289.894202115975;5324.307839980777;5166.4575219601775;5166.793328266865;5204.973975130138;5275.182346736262;5355.7857685692525;5733;5823.126531020339;5882.0588705807295;5897.705114744245;5902.232709747748;6165.32181460039;6167.506599472032;6232.470240029557;6247.3127955925265;6248;6199.504039676815;6251.3123556408755;6256.311805701369;6261.342559031327;6266.937330626681;5780;5867.413258674099;5896.086106653475;5988.610740301867;5989.131575921467;6217.6891155442045;6341.904871426932;6348.841278968062;6356.586821856565;6356.745730170742;6202.34875338092;6207;6226.159468471698;6240.5319601030105;6246.906296405557;6068.362821903725;6127.220070483952;6235.501159907197;6236.501079913596;6240.563160578807;6076.179715738407;6078.3921607838865;6095.75616975316;6137.285055221596;6143.082036032938;6075.058365953284;6111.602745821597;6143.38566143391;6161.291451483047;6179.073139029181;4860.8298709545;4864.610831133501;4871.196252618349;4916.827911023097;4922.704637721748;4427.955720442818;4440.4671439427475;4484.2376795944765;4500.954990450119;4578.130155270488;4583.716559363384;5264.31563896691;5365.980463711882;5734.283214598176;6001.069834175622;5806.419358064244;5820.35976042635;6130.785422510191;6250.656213908188;6276.184096067482;5811.535077193815;5869.236999190163;5889.705514724246;5913.408659134138;5937.228160339128;5459.508644222039;5517.227588137664;5533.889322213614;5536.390996990328;5558.888222355545;5884.529237660891;6334.714937827809;6446.226452825691;6450.838729031718;6523.67381630907;5443.265159203457;6150.616111374905;6207.503399727921;6239.812805615838;6311.747530098928;5346.331708536433;6413.583117097373;6422.903656445251;6433.839154021187;6435.09908612804;6125.815438131457;6139.109829074849;6181.011038233861;6194.845128871814;6196.752129914933;6099.461111717743;6111.257501106225;6123.984276525883;6136.2636483622255;6225.066240064027;4824.951750482591;5981.863445945257;6062.393760623902;6066.878662426815;6122.6938653068055;6108.419700128481;6114.875284800388;6128.014278093809;6130.306415576139;6143.262808463013;5887.087501437284;5899.144624029406;5953.880922381615;5981.312149102735;6004.339522652592;6062.818115456544;6093.146959425772;6113.358097399709;6115.757578772925;6116.305337586134;6064.332923378513;6098.492741543328;6114.206128133634;6127.769884593299;6145.723442445012 14:18:37 INFO - PROCESS | 2054 | |1;ext.html;468.53146853146853;490.9616161817754;499.40570720842175;504.54338823364844;526.9802931327879;29984.95052673157;33070;33669.32661346775;40602.187956240894;40705;41401;41769;41847.16305673892;41895.37156942648;41927.161456770926;8241.958790206041;9591.136797688225;9649.951750241238;9740;9814.411135331868;9569.808603827954;9626.663066792664;9689.854652180224;9704.369216000972;9706.805863882753;9627.085426884434;9655.565499552536;9719.95140024299;9727.805443891119;9737.269704772136;8337.458065225772;9656.565454554562;9658.517074146299;9677.806443871154;9700.805983880284;9680.515974201333;9689.32174747768;9735.951320243425;9755.951220243853;9767.706968790948;40069.99825004369;40197.79901100476;40441.79779101086;40632.79683601593;40756.38865417021;3330.4504756715114;3392.1010932103013;3416.4192087344964;3484.5992710838323;3787.3182827091114;30833.691663083308;31497.52753708696;31648.683513164804;31692.207694807585;32378.676213237803;2552.2598446450506;3247.4804031355106;3302.554155189067;3307.074019274607;3430.0567343980356;362065.1896740526;364743;366620.1668991665;367569;369419;60368.69815650982;60634;60814;60856.391436085956;60956.39043609596;62152.68923655353;62656.37343626505;62745.37254627395;62880.37119628837;63120.68439657772;16165.191740412933;16172.433964811175;16330.836691633169;16359.263833127538;16424.6715065698;11212.495437705324;12128.514859405524;12507.249565026128;12740.980721542255;12791.744165116646;16274.104924229281;17178.509116178084;17313.913430432767;17318.134093295284;17333.7399939001;7103.360697537247;7110.751123710749;7197.89203161953;7252.5648461092505;7254.347108760237;878.5870640798814;906.8618883301415;918.3617385916724;980.9460479673686;1019.0115587879893;23334.64486535196;28613;29623.111306660834;29670.851645742066;29789.85105074504;992.528548939248;1041.8695715148997;1059.904608585231;1071.6356438810842;1140.4696815980442;14450.638734031523;15535.844641553665;15610.907236493564;15685;15861.286242119133;625732;627990;630403;631486;631592;57612;57891.71054144702;57993.23044002127;58222.70888645529;58268.708656456445;1292.1665525735848;1326.84741254755;1367.911085779441;1369.0827145812132;1372.2521225931891;22949.770502295432;25168.622470663322;29123.271918202216;29362.119136425943;30423.39153216879;45755.54244457646;50570.74714626403;51264.48735512597;51378;51532.484675152766;491734;501280;505072.47463762446;509552;512105;36958.44562331621;40834.79582602068;41800.327986880184;41812.3728144072;41838.1632367357;38902.22195556016;46411;47284.81787955329;47827;48165.27752083651;38711.419328710654;38772.6122738769;38807.6119238804;40434.595654043085;40442.59557404388;30838.53742193824;35155.82422087975;35359;36352.63647363493;36482.63517364899;32357.51463727999;33057.66942330546;36646.816765916;38079;38190.80904595459;31215.84392078025;33513.16217094592;34415.31169376648;34588.789392371145;34647.65352346444;23431.531369372857;24438.75561244365;24952.75047249504;25833.225003249932;26107.421368595336 14:18:37 INFO - PROCESS | 2054 | |2;jquery.html;366.2692927609419;366.976146550474;373.60771190250233;375.7069485801073;399.69223697752733;19800.40598782035;19826.504337391572;20222.988850557485;20420.285290014854;20566.588668226646;20568.07443665035;20642.793572064274;20661.896690516565;20690.793092069074;21232;4763.595094416979;5814.883702325951;5835.795747148862;6100.993336099538;6120.69396530174;5079.822206222783;5965;6086.543509236825;6092.177556029924;6148.077788331763;5843.883122337551;5901.498372638331;5961.850953726148;5979.46184843364;5998.490128339096;5692.402297758758;5908.379620139888;5968.104784282393;5982.730777115018;5990.670513121777;5151.150060240094;5187.714675692835;5202.817901373472;5203.843884683465;5218.504242096995;17758.91120544389;25146.87426562874;25451.49097018068;25724.87137564319;25984.09055683042;2218.2901471529117;2325.232673217834;2609.6868375795025;2791.567307067408;2915.4169166166853;13213;15008.924955375262;15516.767248491169;15849;16325.020498770113;1864.869459137861;1887.3488646416963;1902.5433895864892;1910.121344181678;1928.0937959159173;119757;120336;122026.77973220243;122043.3897830514;122715;10394.896051039545;10650.786984260272;11434.256773309708;11526.393136592902;11720.589779357682;13916.095453795471;13932.442702291997;13943.58169254924;13962.720745585235;13973.441062357391;8437.282830959315;8670;8707.521086340186;8869.556522173865;8875.28997680184;7455.478116531899;8841.72856043268;8890.86663700045;9031.77420564478;9034.32242581809;6618.602883826986;6773.356531129535;6783.321667833177;6788.219354774165;6819.408624722573;1622.4970259219679;1643.983560164407;1845.8892466452055;1910.2836436336374;1922.5962547865106;840.2395831772255;895.906993467968;913.9680111196076;953.5470651440648;1001.4391940513336;20918.68621970641;21863.016164272645;21932;21974.340769776933;22024.779752202594;900.5947323704228;937.4703292639637;961.4471678784727;962.8940816510178;977.941323520591;9976.401415915068;10939.56241750321;11147.157737284535;11468.4839182237;11521.308721476738;565100;566100;571405;590576;591832;113290;117543;118266;118767;121205.57588848173;943.9150476457152;954.2699834626517;982.3761911186448;983.2134292565919;990.1138481059555;16607.3357065716;17118.914405427895;18498.81501184971;18768.83856939298;18822;39205.80397097996;50942;51932.48067519276;52163.73918130537;52385;47196.7640161797;69893.65053174905;69944;70284;71393;7755.961220193863;7909.52542847431;7973.8405231896195;8046.597670116588;8085.151059138941;10051.899481005097;12856.292903890377;13018;13330;13410.798838017632;9167.724968250963;11013.229073964745;11135.83296250573;11430.657080287605;11438.599649012245;8205.507669539847;9216.354855160074;11194.496247668712;11570.826437603275;11630.127740419333;9492.382995105296;10890.128789696646;11008.284461509977;11384.886151138382;11815.350155741517;7719.459637825523;7761.805954851174;8131.512109273463;8169.79575510617;8194.180581941997;10499.950004999439;10762.300450470695;11018.11855051578;11614.88385116138;11703.2978021319 14:18:37 INFO - PROCESS | 2054 | |3;mootools.html;1370.397025308864;1489.1660670024783;1667.3997360950057;1794.9910250448745;1826.0960824391927;7455.217202193766;7986.640601172947;8238.382121340908;8489.575521223936;8858.822823543525;8454;8737.912620873789;8748.912510874889;8848.690295839648;8853.203211710945;2097.9475513112143;2339.263132113379;2358.2571489980687;2361.0909799727056;2370.051979208322;2263.173941511353;2292.5529521743265;2298.908043678259;2304.9973261631244;2345.4637212625757;2012.1146695453954;2113.5455876986443;2231.7682317682315;2300.2639155470256;2300.6088964875926;1948.785633580305;2031.6749320108786;2283.360659015478;2313.271319534358;2331.6152834782242;2318.397216723664;2352.870592117433;2357.787799098089;2358.716953965535;2380.571497130516;8973.730788076367;8983.505907175102;9007.594658240328;9048.502332371718;9059.773505662346;5263.131583288753;5427.83716488506;5450.073487507094;5451;5451.64564303319;3504.316658251642;3576.5529308836394;3707.925841483155;3711.740178187528;3730.794806285653;969.7333233360882;1040.1834559870465;1061.273027975839;1081.259337353915;1090.3784842639698;11666.824997624957;11763.294202347886;11853.940730296294;11927.403629818475;11968.16222864391;4574.794134263966;4696.741679207608;4796.712197268175;4840.6127509799135;4844.442889067732;9964.800703986024;10075.899241007495;10076.193904487624;10087.646932357478;10107.7473063174;4917.188663870493;5242.213667949838;5376.274202982548;5401.756920938567;5419.268398766116;4398.450193725785;4552.931706024412;4731.33761273422;4875.366202393737;4941.678790878582;3888.747231429948;3895.5714871364125;4021.8391264349684;4024.7786371749835;4048.8380464781667;1167.2762887009937;1209.4255228766265;1289.4777615065914;1300.1808860417875;1300.206873806977;853.5476197615274;856.4090777363599;898.4070513461215;912.5391677203103;930.874331965176;5599.244102046253;5679.807240479463;5925.229720136441;5965.8366618509845;5990.191324171181;811.3792948394483;922.8569571716395;934.8737920380797;937.9343445958717;975.3855071305032;3526.2947410518;3926.2343842950922;3931.5085614298214;4023.3160362738404;4135.214309281287;10575.735606609742;10607.469626518643;10809.78380432387;10884.891151088546;11067.446627668583;9340.532973351304;10281.948590257001;10760.085392741548;10782.514786834454;10790.51442685081;6908.412784913238;7170.354668079898;7738.303552680286;8002.759917202493;8070.354371650371;5054.4692807254705;5232.424433312409;5857.765689372377;5983.252093488314;6035.245594300713;8900;9591.808163836544;9962.452065136487;10001.699949001542;10026.498675066072;9920.20638348916;9964.05341492557;10058.145057669888;10100.797984040424;10176.033276838689;6938.722451101899;7169.820754481179;7287.963560182166;7348.77953661391;7407.444441667004;8226.259636632492;8317.667293308199;8334.249917507454;8464.111268316738;8479.540933129323;7330.193678695233;7472.663730132266;7492.475526713078;7536.623168841426;7614.923850761422;7283.089613798275;7316.524425912512;7329.890051649123;7432.665530051053;7445.851082978418;6558.639274839929;6560.40956313934;6611.438027767694;6615.206175259;6625.138731964814;4913.1893237615395;4961.42943561495;4990.700557966534;4999.175136102648;5040.319556859777;4215.894602634959;4828.637852161031;5023.4725353838785;5113.948860511347;5123 14:18:37 INFO - PROCESS | 2054 | |4;prototype.html;283.7616402222134;312.08558922357497;314.286569487264;319.028558040766;320.76263564961937;4945.381827271591;5550.5282051025715;5610.859728506789;5645.266115405002;5655.688937108463;4196.685248606359;5363.283749200257;5461.863453413666;5475.425080366564;5584.692841893694;3773.283076215524;4008.47677882405;4044.5753195914444;4106.815193316293;4160.667146628278;3483.895483135497;3714.9442758358646;4152.065785198336;4188.602082802129;4233.767142807144;3589.5154154189113;4143.337066069429;4161.708680392374;4189.455370801791;4219.978900105511;3792.8621413575815;3837.002379381353;4096.91806163878;4215.346621273692;4265.744055356673;2709.6883858356346;3026.757859371245;3094.4739394302796;3280.7867488613165;3475.7740746851373;5289.8840463814395;5335.733213339317;5354.198519051478;5356.276902618175;5369.301990741179;4632.467266264389;4655.556777398983;4729.456112547066;4756;4788.760561971888;4803.279508073782;5821.476067153934;5827.3298570664065;5845.678487683176;5884.558658100659;3925.980370098131;3949.2299001694682;3950.4469374287623;3960.5445373782095;3967.7817720025387;4856.0287942411305;5728.484436400744;6054.274531758428;6127.264728232596;6127.662978536178;3829.272438236726;3972.781497017692;3977.8209980550946;3984.601539845992;4063.4311196432523;3430.519727238189;3627.764195327295;3659.7804131751645;3915.8433662653742;4132.690048246393;4767;4769.356136921471;4790.951645859243;4813.518648135228;4814.363116540393;4631.698939568984;5105.8723531912;5771.691323470562;5845.317450006553;5847.38602446737;1348.379745317165;1374.3540535948089;1377.1392879450343;1383.9584812455641;1384.0795870745842;786.1941509952345;829.4649950781712;829.5520418973687;841.1882533355341;846.2637505370367;5250.291210686509;5331.3868905076415;5512.641678290978;5518.0962567914;5551.3893471718075;5064.746762661852;5307.6730817295675;5320.882614650966;6002.159697642333;6076.878462430726;4497.775111244425;4765.118453086121;5033.874153146201;5065.949340506621;5518.724063796794;3011.533212352089;3083.522054081621;3160.4153231652217;3188.3145123798495;3216.4371235033777;5604.971975140098;6221.4089661482085;6235.074291309905;6254.312025677172;6295.559310848288;5893.351731309553;6206.472449841814;6267.9373206267355;6270.651809860902;6341.492680585634;5360.705161216092;5370.62405631602;6072.817815465543;6419.293877673452;6443.96778016107;5362.70505122222;5628.761672432059;6018;6113.29697084841;6209.658468784261;5173.948260517347;5424.783008679608;5744.885102298014;6104.511639068775;6110.961136606698;5058.962912602834;5971.940280597139;6098.5426093042315;6283.937160628335;6306.810795676137;3367.6463971283642;3639.12509117794;3747.70018398522;3779.8677046303246;3903.746256493319;5386.811461598825;5651.717414129359;5964.105384192232;6084.566173530623;6111.480524155497;5656.002318771058;5661.547076233809;5852.502537284378;5956;6009.2188015557695;4879.80480780779;5322.137251961783;5850.742090450573;5857.824265272048;5901.639344262329;5061.595072394126;5649.71751412436;5692.203091567101;5730.309558680283;5772.653640781398;5203.479652034766;5391.919121213106;5621.325440947113;5657.953278643299;5878.3239927407185;4943.060818444484;5700.401457846866;5730.283714535683;5743.8564035899435;5761.740721667451 14:18:37 INFO - PROCESS | 2054 | |5;yui.html;709.2269426325305;778.9873164885647;788.6727008291557;793.8055176481763;799.2606838674225;13478.865211347884;15116.319765610546;16731.665366692672;17657;17671.5582110447;16680.916595417035;16729.414470493535;16731.247093880775;16776.245068971893;16779.412720554785;674.2583158525632;832.4838600067951;860.8708693695933;862.1593945902757;865.1780808232173;690.1338819781192;840.3445312656138;854.1373213054828;873.4104479476359;874.8250349930007;882.4131952251745;913.7304495173906;914.3188324698109;917.2799352508282;919.1038737231213;909.6134142989237;911.2709832134266;911.3438324406417;911.3483859040817;911.3666002128523;645.8094862015716;647.229796542118;676.245985725917;677.9728810847561;679.9252082270946;14969.550913472613;15389.230538473032;15406.845931540653;15409.152496612682;15425.691486170213;13990.930045349709;14063.64840878976;14095;14264.572062838131;14371.281435928162;11817.17279790415;11824;11934.701632459259;12048.277103373737;12161.331126788024;3295.6210035845943;3605.7295702822394;3726.546646807747;3798.335291324035;3826.2730081284467;120530.39734801358;125213.37393313066;126066;131030;132633;10936.234463587472;10937.83593246102;10948.890511094787;11047.668569942914;11103.888961110448;18559.907200463913;21030.263940762;22119.225827095976;22488.77511224867;22520.77479225187;7789.415793815487;7848.13670496245;7910.920890791019;7965.721199758096;8046.356291496666;4310.849120280775;4339.956600433955;4353.434053573015;4425.889352766207;4464.843730469418;3514.7715398499527;3602.0814692253307;3615.837287322077;3620.3483372992587;3622.692071173927;585.1924344404695;625.1747693045228;628.6353914729445;651.9092693349271;661.0943008078963;621.2327775197627;635.253577046968;641.5893827950116;641.9646919419383;662.2715013485127;9321.533923303808;9405.43567385959;9457.93182440668;9480.525973701288;9776.071273229032;552.4503766933709;576.1703147467717;591.3583761618692;592.5039275828567;627.5544363501965;4340.435743353407;4655.813767449264;4698.107359601665;4787.329773831666;4831.903361932812;165500;170492;172463;172644;173453;142794;143964;146361;146608;146858;120175;121441;122329.65078222883;124056.37971810263;126405.36797315955;7577.052868391451;8621.482711037357;9054.728358149267;9061.22979546746;9201.079892010745;68165;69136.65431672809;69602.3039769616;70072.89781306569;70318.64840675764;76132.61933690518;90166.19667606743;95253;96631;98195;11792.528298868292;11818.46816893259;11899.107566932687;11903.047756179658;11952.64142075739;13235;13237.768154894997;13406.798898016343;13430.39563219677;13734.587962361145;11838.230515016496;12078.879211208126;12270;12303.836148572513;12711.936440317739;11894.643160705193;12288.692782680504;12300;12528.436220369922;12609.369531523203;11813.291202527877;12227.877721222674;12248.938755306166;12428.37858107109;12434.875651243372;10312.535935882754;10433.58265669395;10489.737756556147;10529.947350263506;10796.082333001783;9242.676506322246;9691.951540242253;10540.52162786294;10679.57281708723;10878 14:18:37 INFO - PROCESS | 2054 | __end_tp_report 14:18:37 INFO - PROCESS | 2054 | __start_cc_report 14:18:37 INFO - PROCESS | 2054 | _x_x_mozilla_cycle_collect,359 14:18:37 INFO - PROCESS | 2054 | __end_cc_report 14:18:37 INFO - PROCESS | 2054 | __startTimestamp1476047917052__endTimestamp 14:18:37 INFO - PROCESS | 2054 | 14:18:37 INFO - PROCESS | 2054 | ------- Summary: start ------- 14:18:37 INFO - PROCESS | 2054 | Number of tests: 6 14:18:37 INFO - PROCESS | 2054 | 14:18:37 INFO - PROCESS | 2054 | [#0] dojo.html Cycles:165 Average:5740.66 Median:5981.86 stddev:663.43 (11.1%) stddev-sans-first:627.26 14:18:37 INFO - PROCESS | 2054 | Values: 2911.9 3360.8 3375.4 3406.0 3424.9 5702.3 5799.7 5812.8 5813.8 5818.3 5763.7 5825.6 5885.7 5891.0 5954.8 5241.1 5272.7 5273.8 5390.0 5402.3 5401.5 5411.6 5419.3 5442.8 5442.9 4340.8 5225.2 5225.6 5231.9 5260.6 4080.6 5262.6 5276.3 5289.9 5324.3 5166.5 5166.8 5205.0 5275.2 5355.8 5733.0 5823.1 5882.1 5897.7 5902.2 6165.3 6167.5 6232.5 6247.3 6248.0 6199.5 6251.3 6256.3 6261.3 6266.9 5780.0 5867.4 5896.1 5988.6 5989.1 6217.7 6341.9 6348.8 6356.6 6356.7 6202.3 6207.0 6226.2 6240.5 6246.9 6068.4 6127.2 6235.5 6236.5 6240.6 6076.2 6078.4 6095.8 6137.3 6143.1 6075.1 6111.6 6143.4 6161.3 6179.1 4860.8 4864.6 4871.2 4916.8 4922.7 4428.0 4440.5 4484.2 4501.0 4578.1 4583.7 5264.3 5366.0 5734.3 6001.1 5806.4 5820.4 6130.8 6250.7 6276.2 5811.5 5869.2 5889.7 5913.4 5937.2 5459.5 5517.2 5533.9 5536.4 5558.9 5884.5 6334.7 6446.2 6450.8 6523.7 5443.3 6150.6 6207.5 6239.8 6311.7 5346.3 6413.6 6422.9 6433.8 6435.1 6125.8 6139.1 6181.0 6194.8 6196.8 6099.5 6111.3 6124.0 6136.3 6225.1 4825.0 5981.9 6062.4 6066.9 6122.7 6108.4 6114.9 6128.0 6130.3 6143.3 5887.1 5899.1 5953.9 5981.3 6004.3 6062.8 6093.1 6113.4 6115.8 6116.3 6064.3 6098.5 6114.2 6127.8 6145.7 14:18:37 INFO - PROCESS | 2054 | 14:18:37 INFO - PROCESS | 2054 | [#1] ext.html Cycles:180 Average:64378.01 Median:40438.20 stddev:136477.42 (337.5%) stddev-sans-first:136775.92 14:18:37 INFO - PROCESS | 2054 | Values: 468.5 491.0 499.4 504.5 527.0 29985.0 33070.0 33669.3 40602.2 40705.0 41401.0 41769.0 41847.2 41895.4 41927.2 8242.0 9591.1 9650.0 9740.0 9814.4 9569.8 9626.7 9689.9 9704.4 9706.8 9627.1 9655.6 9720.0 9727.8 9737.3 8337.5 9656.6 9658.5 9677.8 9700.8 9680.5 9689.3 9736.0 9756.0 9767.7 40070.0 40197.8 40441.8 40632.8 40756.4 3330.5 3392.1 3416.4 3484.6 3787.3 30833.7 31497.5 31648.7 31692.2 32378.7 2552.3 3247.5 3302.6 3307.1 3430.1 362065.2 364743.0 366620.2 367569.0 369419.0 60368.7 60634.0 60814.0 60856.4 60956.4 62152.7 62656.4 62745.4 62880.4 63120.7 16165.2 16172.4 16330.8 16359.3 16424.7 11212.5 12128.5 12507.2 12741.0 12791.7 16274.1 17178.5 17313.9 17318.1 17333.7 7103.4 7110.8 7197.9 7252.6 7254.3 878.6 906.9 918.4 980.9 1019.0 23334.6 28613.0 29623.1 29670.9 29789.9 992.5 1041.9 1059.9 1071.6 1140.5 14450.6 15535.8 15610.9 15685.0 15861.3 625732.0 627990.0 630403.0 631486.0 631592.0 57612.0 57891.7 57993.2 58222.7 58268.7 1292.2 1326.8 1367.9 1369.1 1372.3 22949.8 25168.6 29123.3 29362.1 30423.4 45755.5 50570.7 51264.5 51378.0 51532.5 491734.0 501280.0 505072.5 509552.0 512105.0 36958.4 40834.8 41800.3 41812.4 41838.2 38902.2 46411.0 47284.8 47827.0 48165.3 38711.4 38772.6 38807.6 40434.6 40442.6 30838.5 35155.8 35359.0 36352.6 36482.6 32357.5 33057.7 36646.8 38079.0 38190.8 31215.8 33513.2 34415.3 34588.8 34647.7 23431.5 24438.8 24952.8 25833.2 26107.4 14:18:37 INFO - PROCESS | 2054 | 14:18:37 INFO - PROCESS | 2054 | [#2] jquery.html Cycles:180 Average:33920.75 Median:1640.84 stddev:96179.01 (5861.6%) stddev-sans-first:96415.82 14:18:37 INFO - PROCESS | 2054 | Values: 366.3 367.0 373.6 375.7 399.7 19800.4 19826.5 20223.0 20420.3 20566.6 20568.1 20642.8 20661.9 20690.8 21232.0 4763.6 5814.9 5835.8 6101.0 6120.7 5079.8 5965.0 6086.5 6092.2 6148.1 5843.9 5901.5 5961.9 5979.5 5998.5 5692.4 5908.4 5968.1 5982.7 5990.7 5151.2 5187.7 5202.8 5203.8 5218.5 17758.9 25146.9 25451.5 25724.9 25984.1 2218.3 2325.2 2609.7 2791.6 2915.4 13213.0 15008.9 15516.8 15849.0 16325.0 1864.9 1887.3 1902.5 1910.1 1928.1 119757.0 120336.0 122026.8 122043.4 122715.0 10394.9 10650.8 11434.3 11526.4 11720.6 13916.1 13932.4 13943.6 13962.7 13973.4 8437.3 8670.0 8707.5 8869.6 8875.3 7455.5 8841.7 8890.9 9031.8 9034.3 6618.6 6773.4 6783.3 6788.2 6819.4 1622.5 1644.0 1845.9 1910.3 1922.6 840.2 895.9 914.0 953.5 1001.4 20918.7 21863.0 21932.0 21974.3 22024.8 900.6 937.5 961.4 962.9 977.9 9976.4 10939.6 11147.2 11468.5 11521.3 565100.0 566100.0 571405.0 590576.0 591832.0 113290.0 117543.0 118266.0 118767.0 121205.6 943.9 954.3 982.4 983.2 990.1 16607.3 17118.9 18498.8 18768.8 18822.0 39205.8 50942.0 51932.5 52163.7 52385.0 47196.8 69893.7 69944.0 70284.0 71393.0 7756.0 7909.5 7973.8 8046.6 8085.2 10051.9 12856.3 13018.0 13330.0 13410.8 9167.7 11013.2 11135.8 11430.7 11438.6 8205.5 9216.4 11194.5 11570.8 11630.1 9492.4 10890.1 11008.3 11384.9 11815.4 7719.5 7761.8 8131.5 8169.8 8194.2 10500.0 10762.3 11018.1 11614.9 11703.3 14:18:37 INFO - PROCESS | 2054 | 14:18:37 INFO - PROCESS | 2054 | [#3] mootools.html Cycles:180 Average:5650.71 Median:4951.55 stddev:3188.14 (64.4%) stddev-sans-first:3180.86 14:18:37 INFO - PROCESS | 2054 | Values: 1370.4 1489.2 1667.4 1795.0 1826.1 7455.2 7986.6 8238.4 8489.6 8858.8 8454.0 8737.9 8748.9 8848.7 8853.2 2097.9 2339.3 2358.3 2361.1 2370.1 2263.2 2292.6 2298.9 2305.0 2345.5 2012.1 2113.5 2231.8 2300.3 2300.6 1948.8 2031.7 2283.4 2313.3 2331.6 2318.4 2352.9 2357.8 2358.7 2380.6 8973.7 8983.5 9007.6 9048.5 9059.8 5263.1 5427.8 5450.1 5451.0 5451.6 3504.3 3576.6 3707.9 3711.7 3730.8 969.7 1040.2 1061.3 1081.3 1090.4 11666.8 11763.3 11853.9 11927.4 11968.2 4574.8 4696.7 4796.7 4840.6 4844.4 9964.8 10075.9 10076.2 10087.6 10107.7 4917.2 5242.2 5376.3 5401.8 5419.3 4398.5 4552.9 4731.3 4875.4 4941.7 3888.7 3895.6 4021.8 4024.8 4048.8 1167.3 1209.4 1289.5 1300.2 1300.2 853.5 856.4 898.4 912.5 930.9 5599.2 5679.8 5925.2 5965.8 5990.2 811.4 922.9 934.9 937.9 975.4 3526.3 3926.2 3931.5 4023.3 4135.2 10575.7 10607.5 10809.8 10884.9 11067.4 9340.5 10281.9 10760.1 10782.5 10790.5 6908.4 7170.4 7738.3 8002.8 8070.4 5054.5 5232.4 5857.8 5983.3 6035.2 8900.0 9591.8 9962.5 10001.7 10026.5 9920.2 9964.1 10058.1 10100.8 10176.0 6938.7 7169.8 7288.0 7348.8 7407.4 8226.3 8317.7 8334.2 8464.1 8479.5 7330.2 7472.7 7492.5 7536.6 7614.9 7283.1 7316.5 7329.9 7432.7 7445.9 6558.6 6560.4 6611.4 6615.2 6625.1 4913.2 4961.4 4990.7 4999.2 5040.3 4215.9 4828.6 5023.5 5113.9 5123.0 14:18:37 INFO - PROCESS | 2054 | 14:18:37 INFO - PROCESS | 2054 | [#4] prototype.html Cycles:180 Average:4674.04 Median:5321.51 stddev:1481.80 (27.8%) stddev-sans-first:1448.86 14:18:37 INFO - PROCESS | 2054 | Values: 283.8 312.1 314.3 319.0 320.8 4945.4 5550.5 5610.9 5645.3 5655.7 4196.7 5363.3 5461.9 5475.4 5584.7 3773.3 4008.5 4044.6 4106.8 4160.7 3483.9 3714.9 4152.1 4188.6 4233.8 3589.5 4143.3 4161.7 4189.5 4220.0 3792.9 3837.0 4096.9 4215.3 4265.7 2709.7 3026.8 3094.5 3280.8 3475.8 5289.9 5335.7 5354.2 5356.3 5369.3 4632.5 4655.6 4729.5 4756.0 4788.8 4803.3 5821.5 5827.3 5845.7 5884.6 3926.0 3949.2 3950.4 3960.5 3967.8 4856.0 5728.5 6054.3 6127.3 6127.7 3829.3 3972.8 3977.8 3984.6 4063.4 3430.5 3627.8 3659.8 3915.8 4132.7 4767.0 4769.4 4791.0 4813.5 4814.4 4631.7 5105.9 5771.7 5845.3 5847.4 1348.4 1374.4 1377.1 1384.0 1384.1 786.2 829.5 829.6 841.2 846.3 5250.3 5331.4 5512.6 5518.1 5551.4 5064.7 5307.7 5320.9 6002.2 6076.9 4497.8 4765.1 5033.9 5065.9 5518.7 3011.5 3083.5 3160.4 3188.3 3216.4 5605.0 6221.4 6235.1 6254.3 6295.6 5893.4 6206.5 6267.9 6270.7 6341.5 5360.7 5370.6 6072.8 6419.3 6444.0 5362.7 5628.8 6018.0 6113.3 6209.7 5173.9 5424.8 5744.9 6104.5 6111.0 5059.0 5971.9 6098.5 6283.9 6306.8 3367.6 3639.1 3747.7 3779.9 3903.7 5386.8 5651.7 5964.1 6084.6 6111.5 5656.0 5661.5 5852.5 5956.0 6009.2 4879.8 5322.1 5850.7 5857.8 5901.6 5061.6 5649.7 5692.2 5730.3 5772.7 5203.5 5391.9 5621.3 5658.0 5878.3 4943.1 5700.4 5730.3 5743.9 5761.7 14:18:37 INFO - PROCESS | 2054 | 14:18:37 INFO - PROCESS | 2054 | [#5] yui.html Cycles:180 Average:26820.37 Median:3603.91 stddev:44823.75 (1243.8%) stddev-sans-first:44906.61 14:18:37 INFO - PROCESS | 2054 | Values: 709.2 779.0 788.7 793.8 799.3 13478.9 15116.3 16731.7 17657.0 17671.6 16680.9 16729.4 16731.2 16776.2 16779.4 674.3 832.5 860.9 862.2 865.2 690.1 840.3 854.1 873.4 874.8 882.4 913.7 914.3 917.3 919.1 909.6 911.3 911.3 911.3 911.4 645.8 647.2 676.2 678.0 679.9 14969.6 15389.2 15406.8 15409.2 15425.7 13990.9 14063.6 14095.0 14264.6 14371.3 11817.2 11824.0 11934.7 12048.3 12161.3 3295.6 3605.7 3726.5 3798.3 3826.3 120530.4 125213.4 126066.0 131030.0 132633.0 10936.2 10937.8 10948.9 11047.7 11103.9 18559.9 21030.3 22119.2 22488.8 22520.8 7789.4 7848.1 7910.9 7965.7 8046.4 4310.8 4340.0 4353.4 4425.9 4464.8 3514.8 3602.1 3615.8 3620.3 3622.7 585.2 625.2 628.6 651.9 661.1 621.2 635.3 641.6 642.0 662.3 9321.5 9405.4 9457.9 9480.5 9776.1 552.5 576.2 591.4 592.5 627.6 4340.4 4655.8 4698.1 4787.3 4831.9 165500.0 170492.0 172463.0 172644.0 173453.0 142794.0 143964.0 146361.0 146608.0 146858.0 120175.0 121441.0 122329.7 124056.4 126405.4 7577.1 8621.5 9054.7 9061.2 9201.1 68165.0 69136.7 69602.3 70072.9 70318.6 76132.6 90166.2 95253.0 96631.0 98195.0 11792.5 11818.5 11899.1 11903.0 11952.6 13235.0 13237.8 13406.8 13430.4 13734.6 11838.2 12078.9 12270.0 12303.8 12711.9 11894.6 12288.7 12300.0 12528.4 12609.4 11813.3 12227.9 12248.9 12428.4 12434.9 10312.5 10433.6 10489.7 10529.9 10796.1 9242.7 9692.0 10540.5 10679.6 10878.0 14:18:37 INFO - PROCESS | 2054 | -------- Summary: end -------- 14:18:37 INFO - PROCESS | 2054 | 14:18:37 INFO - TEST-INFO | 2054: exit 0 14:18:37 INFO - TEST-OK | dromaeo_css | took 1115073ms 14:18:37 INFO - TEST-START | kraken 14:18:37 INFO - operating with platform_type : mac_ 14:18:37 INFO - Initialising browser for kraken test... 14:18:37 INFO - TEST-INFO | started process 2059 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/tmpRYdJFi/profile http://localhost:52495/getInfo.html) 14:18:40 INFO - PROCESS | 2059 | 2016-10-09 14:18:40.646 plugin-container[2060:36495] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a1b, name = 'com.apple.tsm.portname' 14:18:40 INFO - PROCESS | 2059 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:18:40 INFO - PROCESS | 2059 | 2016-10-09 14:18:40.649 plugin-container[2060:36495] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9403, name = 'com.apple.CFPasteboardClient' 14:18:40 INFO - PROCESS | 2059 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:18:40 INFO - PROCESS | 2059 | 2016-10-09 14:18:40.649 plugin-container[2060:36495] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:18:40 INFO - PROCESS | 2059 | __metrics Screen width/height:1600/1200 14:18:40 INFO - PROCESS | 2059 | colorDepth:24 14:18:40 INFO - PROCESS | 2059 | Browser inner width/height: 1024/689 14:18:40 INFO - PROCESS | 2059 | __metrics 14:18:40 ERROR - PROCESS | 2059 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3083: TypeError: this.tabs is undefined 14:18:41 INFO - TEST-INFO | 2059: exit 0 14:18:41 INFO - Browser initialized. 14:18:41 INFO - Running cycle 1/1 for kraken test... 14:18:41 INFO - TEST-INFO | started process 2061 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/tmpRYdJFi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:18:44 INFO - PROCESS | 2061 | 2016-10-09 14:18:44.114 plugin-container[2062:36614] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d1f, name = 'com.apple.tsm.portname' 14:18:44 INFO - PROCESS | 2061 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:18:44 INFO - PROCESS | 2061 | 2016-10-09 14:18:44.116 plugin-container[2062:36614] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9203, name = 'com.apple.CFPasteboardClient' 14:18:44 INFO - PROCESS | 2061 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:18:44 INFO - PROCESS | 2061 | 2016-10-09 14:18:44.116 plugin-container[2062:36614] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:18:53 INFO - PROCESS | 2061 | RSS: Main: 238886912 14:18:53 INFO - PROCESS | 2061 | 14:18:56 INFO - PROCESS | 2061 | Cycle 1(1): loaded http://localhost:52495/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52495/tests/kraken/driver.html?testName=audio-beat-detection) 14:18:57 INFO - PROCESS | 2061 | RSS: Main: 252637184 14:18:57 INFO - PROCESS | 2061 | 14:19:00 INFO - PROCESS | 2061 | Cycle 1(1): loaded http://localhost:52495/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52495/tests/kraken/driver.html?testName=audio-dft) 14:19:00 INFO - PROCESS | 2061 | RSS: Main: 260116480 14:19:00 INFO - PROCESS | 2061 | 14:19:04 INFO - PROCESS | 2061 | Cycle 1(1): loaded http://localhost:52495/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52495/tests/kraken/driver.html?testName=audio-fft) 14:19:05 INFO - PROCESS | 2061 | RSS: Main: 261062656 14:19:05 INFO - PROCESS | 2061 | 14:19:07 INFO - PROCESS | 2061 | Cycle 1(1): loaded http://localhost:52495/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52495/tests/kraken/driver.html?testName=audio-oscillator) 14:19:07 INFO - PROCESS | 2061 | RSS: Main: 263335936 14:19:07 INFO - PROCESS | 2061 | 14:19:09 INFO - PROCESS | 2061 | Cycle 1(1): loaded http://localhost:52495/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52495/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:19:10 INFO - PROCESS | 2061 | RSS: Main: 263856128 14:19:10 INFO - PROCESS | 2061 | 14:19:13 INFO - PROCESS | 2061 | Cycle 1(1): loaded http://localhost:52495/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52495/tests/kraken/driver.html?testName=imaging-darkroom) 14:19:13 INFO - PROCESS | 2061 | RSS: Main: 264269824 14:19:13 INFO - PROCESS | 2061 | 14:19:16 INFO - PROCESS | 2061 | Cycle 1(1): loaded http://localhost:52495/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52495/tests/kraken/driver.html?testName=imaging-desaturate) 14:19:17 INFO - PROCESS | 2061 | RSS: Main: 264392704 14:19:17 INFO - PROCESS | 2061 | 14:19:20 INFO - PROCESS | 2061 | Cycle 1(1): loaded http://localhost:52495/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52495/tests/kraken/driver.html?testName=json-parse-financial) 14:19:21 INFO - PROCESS | 2061 | RSS: Main: 264650752 14:19:21 INFO - PROCESS | 2061 | 14:19:22 INFO - PROCESS | 2061 | Cycle 1(1): loaded http://localhost:52495/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52495/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:19:23 INFO - PROCESS | 2061 | RSS: Main: 264306688 14:19:23 INFO - PROCESS | 2061 | 14:19:25 INFO - PROCESS | 2061 | Cycle 1(1): loaded http://localhost:52495/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52495/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:19:25 INFO - PROCESS | 2061 | RSS: Main: 264396800 14:19:25 INFO - PROCESS | 2061 | 14:19:28 INFO - PROCESS | 2061 | Cycle 1(1): loaded http://localhost:52495/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52495/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:19:28 INFO - PROCESS | 2061 | RSS: Main: 264462336 14:19:28 INFO - PROCESS | 2061 | 14:19:31 INFO - PROCESS | 2061 | Cycle 1(1): loaded http://localhost:52495/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52495/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:19:32 INFO - PROCESS | 2061 | RSS: Main: 264683520 14:19:32 INFO - PROCESS | 2061 | 14:19:35 INFO - PROCESS | 2061 | Cycle 1(1): loaded http://localhost:52495/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52495/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:19:36 INFO - PROCESS | 2061 | RSS: Main: 265039872 14:19:36 INFO - PROCESS | 2061 | 14:19:38 INFO - PROCESS | 2061 | Cycle 1(1): loaded http://localhost:52495/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52495/tests/kraken/driver.html?testName=ai-astar) 14:19:38 INFO - PROCESS | 2061 | RSS: Main: 266752000 14:19:38 INFO - PROCESS | 2061 | 14:19:38 INFO - PROCESS | 2061 | __start_tp_report 14:19:38 INFO - PROCESS | 2061 | _x_x_mozilla_page_load 14:19:38 INFO - PROCESS | 2061 | _x_x_mozilla_page_load_details 14:19:38 INFO - PROCESS | 2061 | |i|pagename|runs| 14:19:38 INFO - PROCESS | 2061 | |0;ai-astar;125;176;172;119;117;113;96;144;174;132 14:19:38 INFO - PROCESS | 2061 | |1;audio-beat-detection;154;111;115;154;116;117;108;137;142;107 14:19:38 INFO - PROCESS | 2061 | |2;audio-dft;204;254;256;278;204;200;249;275;193;197 14:19:38 INFO - PROCESS | 2061 | |3;audio-fft;85;57;58;84;61;61;59;69;71;66 14:19:38 INFO - PROCESS | 2061 | |4;audio-oscillator;83;71;86;71;70;71;88;70;70;86 14:19:38 INFO - PROCESS | 2061 | |5;imaging-gaussian-blur;89;87;88;105;135;78;134;131;123;87 14:19:38 INFO - PROCESS | 2061 | |6;imaging-darkroom;99;99;116;100;98;119;98;98;116;171 14:19:38 INFO - PROCESS | 2061 | |7;imaging-desaturate;94;94;93;90;127;85;145;148;122;92 14:19:38 INFO - PROCESS | 2061 | |8;json-parse-financial;54;57;56;58;57;58;57;58;57;57 14:19:38 INFO - PROCESS | 2061 | |9;json-stringify-tinderbox;68;75;72;78;75;69;68;71;70;71 14:19:38 INFO - PROCESS | 2061 | |10;stanford-crypto-aes;102;117;113;97;87;91;91;89;89;86 14:19:38 INFO - PROCESS | 2061 | |11;stanford-crypto-ccm;151;167;142;155;158;154;166;164;176;197 14:19:38 INFO - PROCESS | 2061 | |12;stanford-crypto-pbkdf2;193;239;187;198;237;186;165;174;175;173 14:19:38 INFO - PROCESS | 2061 | |13;stanford-crypto-sha256-iterative;68;71;69;91;89;92;89;87;79;68 14:19:38 INFO - PROCESS | 2061 | __end_tp_report 14:19:38 INFO - PROCESS | 2061 | __start_cc_report 14:19:38 INFO - PROCESS | 2061 | _x_x_mozilla_cycle_collect,935 14:19:38 INFO - PROCESS | 2061 | __end_cc_report 14:19:38 INFO - PROCESS | 2061 | __startTimestamp1476047978368__endTimestamp 14:19:38 INFO - PROCESS | 2061 | 14:19:38 INFO - PROCESS | 2061 | ------- Summary: start ------- 14:19:38 INFO - PROCESS | 2061 | Number of tests: 14 14:19:38 INFO - PROCESS | 2061 | 14:19:38 INFO - PROCESS | 2061 | [#0] ai-astar Cycles:10 Average:136.80 Median:158.00 stddev:28.51 (18.0%) stddev-sans-first:29.91 14:19:38 INFO - PROCESS | 2061 | Values: 125.0 176.0 172.0 119.0 117.0 113.0 96.0 144.0 174.0 132.0 14:19:38 INFO - PROCESS | 2061 | 14:19:38 INFO - PROCESS | 2061 | [#1] audio-beat-detection Cycles:10 Average:126.10 Median:127.00 stddev:18.73 (14.7%) stddev-sans-first:16.93 14:19:38 INFO - PROCESS | 2061 | Values: 154.0 111.0 115.0 154.0 116.0 117.0 108.0 137.0 142.0 107.0 14:19:38 INFO - PROCESS | 2061 | 14:19:38 INFO - PROCESS | 2061 | [#2] audio-dft Cycles:10 Average:231.00 Median:251.50 stddev:34.39 (13.7%) stddev-sans-first:35.06 14:19:38 INFO - PROCESS | 2061 | Values: 204.0 254.0 256.0 278.0 204.0 200.0 249.0 275.0 193.0 197.0 14:19:38 INFO - PROCESS | 2061 | 14:19:38 INFO - PROCESS | 2061 | [#3] audio-fft Cycles:10 Average:67.10 Median:67.50 stddev:10.28 (15.2%) stddev-sans-first:8.62 14:19:38 INFO - PROCESS | 2061 | Values: 85.0 57.0 58.0 84.0 61.0 61.0 59.0 69.0 71.0 66.0 14:19:38 INFO - PROCESS | 2061 | 14:19:38 INFO - PROCESS | 2061 | [#4] audio-oscillator Cycles:10 Average:76.60 Median:77.00 stddev:7.97 (10.4%) stddev-sans-first:8.12 14:19:38 INFO - PROCESS | 2061 | Values: 83.0 71.0 86.0 71.0 70.0 71.0 88.0 70.0 70.0 86.0 14:19:38 INFO - PROCESS | 2061 | 14:19:38 INFO - PROCESS | 2061 | [#5] imaging-gaussian-blur Cycles:10 Average:105.70 Median:82.50 stddev:22.75 (27.6%) stddev-sans-first:23.31 14:19:38 INFO - PROCESS | 2061 | Values: 89.0 87.0 88.0 105.0 135.0 78.0 134.0 131.0 123.0 87.0 14:19:38 INFO - PROCESS | 2061 | 14:19:38 INFO - PROCESS | 2061 | [#6] imaging-darkroom Cycles:10 Average:111.40 Median:98.00 stddev:22.68 (23.1%) stddev-sans-first:23.60 14:19:38 INFO - PROCESS | 2061 | Values: 99.0 99.0 116.0 100.0 98.0 119.0 98.0 98.0 116.0 171.0 14:19:38 INFO - PROCESS | 2061 | 14:19:38 INFO - PROCESS | 2061 | [#7] imaging-desaturate Cycles:10 Average:109.00 Median:91.00 stddev:24.13 (26.5%) stddev-sans-first:24.98 14:19:38 INFO - PROCESS | 2061 | Values: 94.0 94.0 93.0 90.0 127.0 85.0 145.0 148.0 122.0 92.0 14:19:38 INFO - PROCESS | 2061 | 14:19:38 INFO - PROCESS | 2061 | [#8] json-parse-financial Cycles:10 Average:56.90 Median:57.00 stddev:1.20 (2.1%) stddev-sans-first:0.67 14:19:38 INFO - PROCESS | 2061 | Values: 54.0 57.0 56.0 58.0 57.0 58.0 57.0 58.0 57.0 57.0 14:19:38 INFO - PROCESS | 2061 | 14:19:38 INFO - PROCESS | 2061 | [#9] json-stringify-tinderbox Cycles:10 Average:71.70 Median:71.50 stddev:3.33 (4.7%) stddev-sans-first:3.26 14:19:38 INFO - PROCESS | 2061 | Values: 68.0 75.0 72.0 78.0 75.0 69.0 68.0 71.0 70.0 71.0 14:19:38 INFO - PROCESS | 2061 | 14:19:38 INFO - PROCESS | 2061 | [#10] stanford-crypto-aes Cycles:10 Average:96.20 Median:89.00 stddev:11.03 (12.4%) stddev-sans-first:11.50 14:19:38 INFO - PROCESS | 2061 | Values: 102.0 117.0 113.0 97.0 87.0 91.0 91.0 89.0 89.0 86.0 14:19:38 INFO - PROCESS | 2061 | 14:19:38 INFO - PROCESS | 2061 | [#11] stanford-crypto-ccm Cycles:10 Average:163.00 Median:165.00 stddev:15.30 (9.3%) stddev-sans-first:15.60 14:19:38 INFO - PROCESS | 2061 | Values: 151.0 167.0 142.0 155.0 158.0 154.0 166.0 164.0 176.0 197.0 14:19:38 INFO - PROCESS | 2061 | 14:19:38 INFO - PROCESS | 2061 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:192.70 Median:190.00 stddev:25.88 (13.6%) stddev-sans-first:27.45 14:19:38 INFO - PROCESS | 2061 | Values: 193.0 239.0 187.0 198.0 237.0 186.0 165.0 174.0 175.0 173.0 14:19:38 INFO - PROCESS | 2061 | 14:19:38 INFO - PROCESS | 2061 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:80.30 Median:88.00 stddev:10.36 (11.8%) stddev-sans-first:9.99 14:19:38 INFO - PROCESS | 2061 | Values: 68.0 71.0 69.0 91.0 89.0 92.0 89.0 87.0 79.0 68.0 14:19:38 INFO - PROCESS | 2061 | -------- Summary: end -------- 14:19:38 INFO - PROCESS | 2061 | 14:19:39 INFO - TEST-INFO | 2061: exit 0 14:19:39 INFO - TEST-OK | kraken | took 61526ms 14:19:39 INFO - SUITE-END | took 1176s 14:19:39 INFO - Completed test suite (00:19:36) 14:19:39 INFO - javascript benchmark 14:19:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7369.701029606582, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2911.9272018199554, 3360.7815491993024, 3375.4093033719078, 3405.982970085149, 3424.948625770613, 5702.315722113352, 5799.681017544039, 5812.796552120672, 5813.767449302033, 5818.272715910506, 5763.740631671574, 5825.621334613258, 5885.735141918613, 5891.0, 5954.821355359335, 5241.109011468059, 5272.710000949946, 5273.841784746454, 5389.973050134744, 5402.297701298845, 5401.4868587484125, 5411.621186516945, 5419.349678038641, 5442.755076021588, 5442.945570544303, 4340.761258130801, 5225.242339860737, 5225.581953443753, 5231.921521177185, 5260.579153667697, 4080.6123418275515, 5262.552683021948, 5276.34045744282, 5289.894202115975, 5324.307839980777, 5166.4575219601775, 5166.793328266865, 5204.973975130138, 5275.182346736262, 5355.7857685692525, 5733.0, 5823.126531020339, 5882.0588705807295, 5897.705114744245, 5902.232709747748, 6165.32181460039, 6167.506599472032, 6232.470240029557, 6247.3127955925265, 6248.0, 6199.504039676815, 6251.3123556408755, 6256.311805701369, 6261.342559031327, 6266.937330626681, 5780.0, 5867.413258674099, 5896.086106653475, 5988.610740301867, 5989.131575921467, 6217.6891155442045, 6341.904871426932, 6348.841278968062, 6356.586821856565, 6356.745730170742, 6202.34875338092, 6207.0, 6226.159468471698, 6240.5319601030105, 6246.906296405557, 6068.362821903725, 6127.220070483952, 6235.501159907197, 6236.501079913596, 6240.563160578807, 6076.179715738407, 6078.3921607838865, 6095.75616975316, 6137.285055221596, 6143.082036032938, 6075.058365953284, 6111.602745821597, 6143.38566143391, 6161.291451483047, 6179.073139029181, 4860.8298709545, 4864.610831133501, 4871.196252618349, 4916.827911023097, 4922.704637721748, 4427.955720442818, 4440.4671439427475, 4484.2376795944765, 4500.954990450119, 4578.130155270488, 4583.716559363384, 5264.31563896691, 5365.980463711882, 5734.283214598176, 6001.069834175622, 5806.419358064244, 5820.35976042635, 6130.785422510191, 6250.656213908188, 6276.184096067482, 5811.535077193815, 5869.236999190163, 5889.705514724246, 5913.408659134138, 5937.228160339128, 5459.508644222039, 5517.227588137664, 5533.889322213614, 5536.390996990328, 5558.888222355545, 5884.529237660891, 6334.714937827809, 6446.226452825691, 6450.838729031718, 6523.67381630907, 5443.265159203457, 6150.616111374905, 6207.503399727921, 6239.812805615838, 6311.747530098928, 5346.331708536433, 6413.583117097373, 6422.903656445251, 6433.839154021187, 6435.09908612804, 6125.815438131457, 6139.109829074849, 6181.011038233861, 6194.845128871814, 6196.752129914933, 6099.461111717743, 6111.257501106225, 6123.984276525883, 6136.2636483622255, 6225.066240064027, 4824.951750482591, 5981.863445945257, 6062.393760623902, 6066.878662426815, 6122.6938653068055, 6108.419700128481, 6114.875284800388, 6128.014278093809, 6130.306415576139, 6143.262808463013, 5887.087501437284, 5899.144624029406, 5953.880922381615, 5981.312149102735, 6004.339522652592, 6062.818115456544, 6093.146959425772, 6113.358097399709, 6115.757578772925, 6116.305337586134, 6064.332923378513, 6098.492741543328, 6114.206128133634, 6127.769884593299, 6145.723442445012], "value": 5698.670481885485, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [468.53146853146853, 490.9616161817754, 499.40570720842175, 504.54338823364844, 526.9802931327879, 29984.95052673157, 33070.0, 33669.32661346775, 40602.187956240894, 40705.0, 41401.0, 41769.0, 41847.16305673892, 41895.37156942648, 41927.161456770926, 8241.958790206041, 9591.136797688225, 9649.951750241238, 9740.0, 9814.411135331868, 9569.808603827954, 9626.663066792664, 9689.854652180224, 9704.369216000972, 9706.805863882753, 9627.085426884434, 9655.565499552536, 9719.95140024299, 9727.805443891119, 9737.269704772136, 8337.458065225772, 9656.565454554562, 9658.517074146299, 9677.806443871154, 9700.805983880284, 9680.515974201333, 9689.32174747768, 9735.951320243425, 9755.951220243853, 9767.706968790948, 40069.99825004369, 40197.79901100476, 40441.79779101086, 40632.79683601593, 40756.38865417021, 3330.4504756715114, 3392.1010932103013, 3416.4192087344964, 3484.5992710838323, 3787.3182827091114, 30833.691663083308, 31497.52753708696, 31648.683513164804, 31692.207694807585, 32378.676213237803, 2552.2598446450506, 3247.4804031355106, 3302.554155189067, 3307.074019274607, 3430.0567343980356, 362065.1896740526, 364743.0, 366620.1668991665, 367569.0, 369419.0, 60368.69815650982, 60634.0, 60814.0, 60856.391436085956, 60956.39043609596, 62152.68923655353, 62656.37343626505, 62745.37254627395, 62880.37119628837, 63120.68439657772, 16165.191740412933, 16172.433964811175, 16330.836691633169, 16359.263833127538, 16424.6715065698, 11212.495437705324, 12128.514859405524, 12507.249565026128, 12740.980721542255, 12791.744165116646, 16274.104924229281, 17178.509116178084, 17313.913430432767, 17318.134093295284, 17333.7399939001, 7103.360697537247, 7110.751123710749, 7197.89203161953, 7252.5648461092505, 7254.347108760237, 878.5870640798814, 906.8618883301415, 918.3617385916724, 980.9460479673686, 1019.0115587879893, 23334.64486535196, 28613.0, 29623.111306660834, 29670.851645742066, 29789.85105074504, 992.528548939248, 1041.8695715148997, 1059.904608585231, 1071.6356438810842, 1140.4696815980442, 14450.638734031523, 15535.844641553665, 15610.907236493564, 15685.0, 15861.286242119133, 625732.0, 627990.0, 630403.0, 631486.0, 631592.0, 57612.0, 57891.71054144702, 57993.23044002127, 58222.70888645529, 58268.708656456445, 1292.1665525735848, 1326.84741254755, 1367.911085779441, 1369.0827145812132, 1372.2521225931891, 22949.770502295432, 25168.622470663322, 29123.271918202216, 29362.119136425943, 30423.39153216879, 45755.54244457646, 50570.74714626403, 51264.48735512597, 51378.0, 51532.484675152766, 491734.0, 501280.0, 505072.47463762446, 509552.0, 512105.0, 36958.44562331621, 40834.79582602068, 41800.327986880184, 41812.3728144072, 41838.1632367357, 38902.22195556016, 46411.0, 47284.81787955329, 47827.0, 48165.27752083651, 38711.419328710654, 38772.6122738769, 38807.6119238804, 40434.595654043085, 40442.59557404388, 30838.53742193824, 35155.82422087975, 35359.0, 36352.63647363493, 36482.63517364899, 32357.51463727999, 33057.66942330546, 36646.816765916, 38079.0, 38190.80904595459, 31215.84392078025, 33513.16217094592, 34415.31169376648, 34588.789392371145, 34647.65352346444, 23431.531369372857, 24438.75561244365, 24952.75047249504, 25833.225003249932, 26107.421368595336], "value": 19591.485291334473, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.2692927609419, 366.976146550474, 373.60771190250233, 375.7069485801073, 399.69223697752733, 19800.40598782035, 19826.504337391572, 20222.988850557485, 20420.285290014854, 20566.588668226646, 20568.07443665035, 20642.793572064274, 20661.896690516565, 20690.793092069074, 21232.0, 4763.595094416979, 5814.883702325951, 5835.795747148862, 6100.993336099538, 6120.69396530174, 5079.822206222783, 5965.0, 6086.543509236825, 6092.177556029924, 6148.077788331763, 5843.883122337551, 5901.498372638331, 5961.850953726148, 5979.46184843364, 5998.490128339096, 5692.402297758758, 5908.379620139888, 5968.104784282393, 5982.730777115018, 5990.670513121777, 5151.150060240094, 5187.714675692835, 5202.817901373472, 5203.843884683465, 5218.504242096995, 17758.91120544389, 25146.87426562874, 25451.49097018068, 25724.87137564319, 25984.09055683042, 2218.2901471529117, 2325.232673217834, 2609.6868375795025, 2791.567307067408, 2915.4169166166853, 13213.0, 15008.924955375262, 15516.767248491169, 15849.0, 16325.020498770113, 1864.869459137861, 1887.3488646416963, 1902.5433895864892, 1910.121344181678, 1928.0937959159173, 119757.0, 120336.0, 122026.77973220243, 122043.3897830514, 122715.0, 10394.896051039545, 10650.786984260272, 11434.256773309708, 11526.393136592902, 11720.589779357682, 13916.095453795471, 13932.442702291997, 13943.58169254924, 13962.720745585235, 13973.441062357391, 8437.282830959315, 8670.0, 8707.521086340186, 8869.556522173865, 8875.28997680184, 7455.478116531899, 8841.72856043268, 8890.86663700045, 9031.77420564478, 9034.32242581809, 6618.602883826986, 6773.356531129535, 6783.321667833177, 6788.219354774165, 6819.408624722573, 1622.4970259219679, 1643.983560164407, 1845.8892466452055, 1910.2836436336374, 1922.5962547865106, 840.2395831772255, 895.906993467968, 913.9680111196076, 953.5470651440648, 1001.4391940513336, 20918.68621970641, 21863.016164272645, 21932.0, 21974.340769776933, 22024.779752202594, 900.5947323704228, 937.4703292639637, 961.4471678784727, 962.8940816510178, 977.941323520591, 9976.401415915068, 10939.56241750321, 11147.157737284535, 11468.4839182237, 11521.308721476738, 565100.0, 566100.0, 571405.0, 590576.0, 591832.0, 113290.0, 117543.0, 118266.0, 118767.0, 121205.57588848173, 943.9150476457152, 954.2699834626517, 982.3761911186448, 983.2134292565919, 990.1138481059555, 16607.3357065716, 17118.914405427895, 18498.81501184971, 18768.83856939298, 18822.0, 39205.80397097996, 50942.0, 51932.48067519276, 52163.73918130537, 52385.0, 47196.7640161797, 69893.65053174905, 69944.0, 70284.0, 71393.0, 7755.961220193863, 7909.52542847431, 7973.8405231896195, 8046.597670116588, 8085.151059138941, 10051.899481005097, 12856.292903890377, 13018.0, 13330.0, 13410.798838017632, 9167.724968250963, 11013.229073964745, 11135.83296250573, 11430.657080287605, 11438.599649012245, 8205.507669539847, 9216.354855160074, 11194.496247668712, 11570.826437603275, 11630.127740419333, 9492.382995105296, 10890.128789696646, 11008.284461509977, 11384.886151138382, 11815.350155741517, 7719.459637825523, 7761.805954851174, 8131.512109273463, 8169.79575510617, 8194.180581941997, 10499.950004999439, 10762.300450470695, 11018.11855051578, 11614.88385116138, 11703.2978021319], "value": 9632.413020130145, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1370.397025308864, 1489.1660670024783, 1667.3997360950057, 1794.9910250448745, 1826.0960824391927, 7455.217202193766, 7986.640601172947, 8238.382121340908, 8489.575521223936, 8858.822823543525, 8454.0, 8737.912620873789, 8748.912510874889, 8848.690295839648, 8853.203211710945, 2097.9475513112143, 2339.263132113379, 2358.2571489980687, 2361.0909799727056, 2370.051979208322, 2263.173941511353, 2292.5529521743265, 2298.908043678259, 2304.9973261631244, 2345.4637212625757, 2012.1146695453954, 2113.5455876986443, 2231.7682317682315, 2300.2639155470256, 2300.6088964875926, 1948.785633580305, 2031.6749320108786, 2283.360659015478, 2313.271319534358, 2331.6152834782242, 2318.397216723664, 2352.870592117433, 2357.787799098089, 2358.716953965535, 2380.571497130516, 8973.730788076367, 8983.505907175102, 9007.594658240328, 9048.502332371718, 9059.773505662346, 5263.131583288753, 5427.83716488506, 5450.073487507094, 5451.0, 5451.64564303319, 3504.316658251642, 3576.5529308836394, 3707.925841483155, 3711.740178187528, 3730.794806285653, 969.7333233360882, 1040.1834559870465, 1061.273027975839, 1081.259337353915, 1090.3784842639698, 11666.824997624957, 11763.294202347886, 11853.940730296294, 11927.403629818475, 11968.16222864391, 4574.794134263966, 4696.741679207608, 4796.712197268175, 4840.6127509799135, 4844.442889067732, 9964.800703986024, 10075.899241007495, 10076.193904487624, 10087.646932357478, 10107.7473063174, 4917.188663870493, 5242.213667949838, 5376.274202982548, 5401.756920938567, 5419.268398766116, 4398.450193725785, 4552.931706024412, 4731.33761273422, 4875.366202393737, 4941.678790878582, 3888.747231429948, 3895.5714871364125, 4021.8391264349684, 4024.7786371749835, 4048.8380464781667, 1167.2762887009937, 1209.4255228766265, 1289.4777615065914, 1300.1808860417875, 1300.206873806977, 853.5476197615274, 856.4090777363599, 898.4070513461215, 912.5391677203103, 930.874331965176, 5599.244102046253, 5679.807240479463, 5925.229720136441, 5965.8366618509845, 5990.191324171181, 811.3792948394483, 922.8569571716395, 934.8737920380797, 937.9343445958717, 975.3855071305032, 3526.2947410518, 3926.2343842950922, 3931.5085614298214, 4023.3160362738404, 4135.214309281287, 10575.735606609742, 10607.469626518643, 10809.78380432387, 10884.891151088546, 11067.446627668583, 9340.532973351304, 10281.948590257001, 10760.085392741548, 10782.514786834454, 10790.51442685081, 6908.412784913238, 7170.354668079898, 7738.303552680286, 8002.759917202493, 8070.354371650371, 5054.4692807254705, 5232.424433312409, 5857.765689372377, 5983.252093488314, 6035.245594300713, 8900.0, 9591.808163836544, 9962.452065136487, 10001.699949001542, 10026.498675066072, 9920.20638348916, 9964.05341492557, 10058.145057669888, 10100.797984040424, 10176.033276838689, 6938.722451101899, 7169.820754481179, 7287.963560182166, 7348.77953661391, 7407.444441667004, 8226.259636632492, 8317.667293308199, 8334.249917507454, 8464.111268316738, 8479.540933129323, 7330.193678695233, 7472.663730132266, 7492.475526713078, 7536.623168841426, 7614.923850761422, 7283.089613798275, 7316.524425912512, 7329.890051649123, 7432.665530051053, 7445.851082978418, 6558.639274839929, 6560.40956313934, 6611.438027767694, 6615.206175259, 6625.138731964814, 4913.1893237615395, 4961.42943561495, 4990.700557966534, 4999.175136102648, 5040.319556859777, 4215.894602634959, 4828.637852161031, 5023.4725353838785, 5113.948860511347, 5123.0], "value": 4531.0663090702365, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [283.7616402222134, 312.08558922357497, 314.286569487264, 319.028558040766, 320.76263564961937, 4945.381827271591, 5550.5282051025715, 5610.859728506789, 5645.266115405002, 5655.688937108463, 4196.685248606359, 5363.283749200257, 5461.863453413666, 5475.425080366564, 5584.692841893694, 3773.283076215524, 4008.47677882405, 4044.5753195914444, 4106.815193316293, 4160.667146628278, 3483.895483135497, 3714.9442758358646, 4152.065785198336, 4188.602082802129, 4233.767142807144, 3589.5154154189113, 4143.337066069429, 4161.708680392374, 4189.455370801791, 4219.978900105511, 3792.8621413575815, 3837.002379381353, 4096.91806163878, 4215.346621273692, 4265.744055356673, 2709.6883858356346, 3026.757859371245, 3094.4739394302796, 3280.7867488613165, 3475.7740746851373, 5289.8840463814395, 5335.733213339317, 5354.198519051478, 5356.276902618175, 5369.301990741179, 4632.467266264389, 4655.556777398983, 4729.456112547066, 4756.0, 4788.760561971888, 4803.279508073782, 5821.476067153934, 5827.3298570664065, 5845.678487683176, 5884.558658100659, 3925.980370098131, 3949.2299001694682, 3950.4469374287623, 3960.5445373782095, 3967.7817720025387, 4856.0287942411305, 5728.484436400744, 6054.274531758428, 6127.264728232596, 6127.662978536178, 3829.272438236726, 3972.781497017692, 3977.8209980550946, 3984.601539845992, 4063.4311196432523, 3430.519727238189, 3627.764195327295, 3659.7804131751645, 3915.8433662653742, 4132.690048246393, 4767.0, 4769.356136921471, 4790.951645859243, 4813.518648135228, 4814.363116540393, 4631.698939568984, 5105.8723531912, 5771.691323470562, 5845.317450006553, 5847.38602446737, 1348.379745317165, 1374.3540535948089, 1377.1392879450343, 1383.9584812455641, 1384.0795870745842, 786.1941509952345, 829.4649950781712, 829.5520418973687, 841.1882533355341, 846.2637505370367, 5250.291210686509, 5331.3868905076415, 5512.641678290978, 5518.0962567914, 5551.3893471718075, 5064.746762661852, 5307.6730817295675, 5320.882614650966, 6002.159697642333, 6076.878462430726, 4497.775111244425, 4765.118453086121, 5033.874153146201, 5065.949340506621, 5518.724063796794, 3011.533212352089, 3083.522054081621, 3160.4153231652217, 3188.3145123798495, 3216.4371235033777, 5604.971975140098, 6221.4089661482085, 6235.074291309905, 6254.312025677172, 6295.559310848288, 5893.351731309553, 6206.472449841814, 6267.9373206267355, 6270.651809860902, 6341.492680585634, 5360.705161216092, 5370.62405631602, 6072.817815465543, 6419.293877673452, 6443.96778016107, 5362.70505122222, 5628.761672432059, 6018.0, 6113.29697084841, 6209.658468784261, 5173.948260517347, 5424.783008679608, 5744.885102298014, 6104.511639068775, 6110.961136606698, 5058.962912602834, 5971.940280597139, 6098.5426093042315, 6283.937160628335, 6306.810795676137, 3367.6463971283642, 3639.12509117794, 3747.70018398522, 3779.8677046303246, 3903.746256493319, 5386.811461598825, 5651.717414129359, 5964.105384192232, 6084.566173530623, 6111.480524155497, 5656.002318771058, 5661.547076233809, 5852.502537284378, 5956.0, 6009.2188015557695, 4879.80480780779, 5322.137251961783, 5850.742090450573, 5857.824265272048, 5901.639344262329, 5061.595072394126, 5649.71751412436, 5692.203091567101, 5730.309558680283, 5772.653640781398, 5203.479652034766, 5391.919121213106, 5621.325440947113, 5657.953278643299, 5878.3239927407185, 4943.060818444484, 5700.401457846866, 5730.283714535683, 5743.8564035899435, 5761.740721667451], "value": 4195.11017422096, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [709.2269426325305, 778.9873164885647, 788.6727008291557, 793.8055176481763, 799.2606838674225, 13478.865211347884, 15116.319765610546, 16731.665366692672, 17657.0, 17671.5582110447, 16680.916595417035, 16729.414470493535, 16731.247093880775, 16776.245068971893, 16779.412720554785, 674.2583158525632, 832.4838600067951, 860.8708693695933, 862.1593945902757, 865.1780808232173, 690.1338819781192, 840.3445312656138, 854.1373213054828, 873.4104479476359, 874.8250349930007, 882.4131952251745, 913.7304495173906, 914.3188324698109, 917.2799352508282, 919.1038737231213, 909.6134142989237, 911.2709832134266, 911.3438324406417, 911.3483859040817, 911.3666002128523, 645.8094862015716, 647.229796542118, 676.245985725917, 677.9728810847561, 679.9252082270946, 14969.550913472613, 15389.230538473032, 15406.845931540653, 15409.152496612682, 15425.691486170213, 13990.930045349709, 14063.64840878976, 14095.0, 14264.572062838131, 14371.281435928162, 11817.17279790415, 11824.0, 11934.701632459259, 12048.277103373737, 12161.331126788024, 3295.6210035845943, 3605.7295702822394, 3726.546646807747, 3798.335291324035, 3826.2730081284467, 120530.39734801358, 125213.37393313066, 126066.0, 131030.0, 132633.0, 10936.234463587472, 10937.83593246102, 10948.890511094787, 11047.668569942914, 11103.888961110448, 18559.907200463913, 21030.263940762, 22119.225827095976, 22488.77511224867, 22520.77479225187, 7789.415793815487, 7848.13670496245, 7910.920890791019, 7965.721199758096, 8046.356291496666, 4310.849120280775, 4339.956600433955, 4353.434053573015, 4425.889352766207, 4464.843730469418, 3514.7715398499527, 3602.0814692253307, 3615.837287322077, 3620.3483372992587, 3622.692071173927, 585.1924344404695, 625.1747693045228, 628.6353914729445, 651.9092693349271, 661.0943008078963, 621.2327775197627, 635.253577046968, 641.5893827950116, 641.9646919419383, 662.2715013485127, 9321.533923303808, 9405.43567385959, 9457.93182440668, 9480.525973701288, 9776.071273229032, 552.4503766933709, 576.1703147467717, 591.3583761618692, 592.5039275828567, 627.5544363501965, 4340.435743353407, 4655.813767449264, 4698.107359601665, 4787.329773831666, 4831.903361932812, 165500.0, 170492.0, 172463.0, 172644.0, 173453.0, 142794.0, 143964.0, 146361.0, 146608.0, 146858.0, 120175.0, 121441.0, 122329.65078222883, 124056.37971810263, 126405.36797315955, 7577.052868391451, 8621.482711037357, 9054.728358149267, 9061.22979546746, 9201.079892010745, 68165.0, 69136.65431672809, 69602.3039769616, 70072.89781306569, 70318.64840675764, 76132.61933690518, 90166.19667606743, 95253.0, 96631.0, 98195.0, 11792.528298868292, 11818.46816893259, 11899.107566932687, 11903.047756179658, 11952.64142075739, 13235.0, 13237.768154894997, 13406.798898016343, 13430.39563219677, 13734.587962361145, 11838.230515016496, 12078.879211208126, 12270.0, 12303.836148572513, 12711.936440317739, 11894.643160705193, 12288.692782680504, 12300.0, 12528.436220369922, 12609.369531523203, 11813.291202527877, 12227.877721222674, 12248.938755306166, 12428.37858107109, 12434.875651243372, 10312.535935882754, 10433.58265669395, 10489.737756556147, 10529.947350263506, 10796.082333001783, 9242.676506322246, 9691.951540242253, 10540.52162786294, 10679.57281708723, 10878.0], "value": 7836.727824525466, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1624.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 176.0, 172.0, 119.0, 117.0, 113.0, 96.0, 144.0, 174.0, 132.0], "value": 136.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 111.0, 115.0, 154.0, 116.0, 117.0, 108.0, 137.0, 142.0, 107.0], "value": 126.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [204.0, 254.0, 256.0, 278.0, 204.0, 200.0, 249.0, 275.0, 193.0, 197.0], "value": 231.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 57.0, 58.0, 84.0, 61.0, 61.0, 59.0, 69.0, 71.0, 66.0], "value": 67.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 71.0, 86.0, 71.0, 70.0, 71.0, 88.0, 70.0, 70.0, 86.0], "value": 76.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 88.0, 105.0, 135.0, 78.0, 134.0, 131.0, 123.0, 87.0], "value": 105.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 99.0, 116.0, 100.0, 98.0, 119.0, 98.0, 98.0, 116.0, 171.0], "value": 111.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 93.0, 90.0, 127.0, 85.0, 145.0, 148.0, 122.0, 92.0], "value": 109.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 57.0, 56.0, 58.0, 57.0, 58.0, 57.0, 58.0, 57.0, 57.0], "value": 56.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 75.0, 72.0, 78.0, 75.0, 69.0, 68.0, 71.0, 70.0, 71.0], "value": 71.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 117.0, 113.0, 97.0, 87.0, 91.0, 91.0, 89.0, 89.0, 86.0], "value": 96.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 167.0, 142.0, 155.0, 158.0, 154.0, 166.0, 164.0, 176.0, 197.0], "value": 163.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [193.0, 239.0, 187.0, 198.0, 237.0, 186.0, 165.0, 174.0, 175.0, 173.0], "value": 192.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 71.0, 69.0, 91.0, 89.0, 92.0, 89.0, 87.0, 79.0, 68.0], "value": 80.3, "unit": "score"}]}]} 14:19:39 INFO - Return code: 0 14:19:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:19:39 ERROR - # TBPL SUCCESS # 14:19:39 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:19:39 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:19:39 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:19:39 INFO - 2016-10-09 14:19:39.702 screenresolution[2066:36993] starting screenresolution argv=screenresolution get 14:19:39 INFO - 2016-10-09 14:19:39.704 screenresolution[2066:36993] Display 0: 1600x1200x32@60 14:19:39 INFO - 2016-10-09 14:19:39.710 screenresolution[2067:36996] starting screenresolution argv=screenresolution list 14:19:39 INFO - Available Modes on Display 0 14:19:39 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:19:39 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:19:39 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:19:39 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:19:39 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:19:39 INFO - Intel Iris: 14:19:39 INFO - Chipset Model: Intel Iris 14:19:39 INFO - Type: GPU 14:19:39 INFO - Bus: Built-In 14:19:39 INFO - VRAM (Dynamic, Max): 1536 MB 14:19:39 INFO - Vendor: Intel (0x8086) 14:19:39 INFO - Device ID: 0x0a2e 14:19:39 INFO - Revision ID: 0x0009 14:19:39 INFO - Displays: 14:19:39 INFO - Display: 14:19:39 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:19:39 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:19:39 INFO - Display Serial Number: 1600x1200 60 14:19:39 INFO - Main Display: Yes 14:19:39 INFO - Mirror: Off 14:19:39 INFO - Online: Yes 14:19:39 INFO - Rotation: Supported 14:19:39 INFO - Return code: 0 14:19:39 INFO - Running post-action listener: _resource_record_post_action 14:19:39 INFO - [mozharness: 2016-10-09 21:19:39.945758Z] Finished run-tests step (success) 14:19:39 INFO - Running post-run listener: _resource_record_post_run 14:19:40 INFO - Total resource usage - Wall time: 1212s; CPU: 54.0%; Read bytes: 2180608; Write bytes: 711973376; Read time: 17; Write time: 2085 14:19:40 INFO - TinderboxPrint: CPU usage
54.4% 14:19:40 INFO - TinderboxPrint: I/O read bytes / time
2,180,608 / 17 14:19:40 INFO - TinderboxPrint: I/O write bytes / time
711,973,376 / 2,085 14:19:40 INFO - TinderboxPrint: CPU idle
2,210.7 (45.6%) 14:19:40 INFO - TinderboxPrint: CPU system
981.4 (20.2%) 14:19:40 INFO - TinderboxPrint: CPU user
1,657.7 (34.2%) 14:19:40 INFO - TinderboxPrint: Swap in / out
409,640,960 / 0 14:19:40 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 393599488; Write bytes: 389097472; Read time: 29380; Write time: 879 14:19:40 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 2180608; Write bytes: 300593664; Read time: 17; Write time: 1157 14:19:40 INFO - Running post-run listener: _upload_blobber_files 14:19:40 INFO - Blob upload gear active. 14:19:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:19:40 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 14:19:40 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:19:40 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:19:40 INFO - (blobuploader) - INFO - Open directory for files ... 14:19:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:19:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:19:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:19:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:19:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:19:41 INFO - (blobuploader) - INFO - Done attempting. 14:19:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:19:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:19:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:19:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:19:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:19:42 INFO - (blobuploader) - INFO - Done attempting. 14:19:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:19:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:19:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:19:45 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:19:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:19:45 INFO - (blobuploader) - INFO - Done attempting. 14:19:45 INFO - (blobuploader) - INFO - Iteration through files over. 14:19:45 INFO - Return code: 0 14:19:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:19:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:19:45 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bba9c5a49286c9655976bc121603e1f2d5078c743cecab9ad070f47528f796ff4ea7b93d686801305c2d07fa538840aea4ad8c1fe5789761b688d8e52f0a5942", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b0dd3327cf48e49e1ae7c463742b8317bfab24020ceabacf98fc2479454ac8e04755c98eaf1176509c55d563ab944ef12d024cc187e75250b78b90e4a4a7a0e5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/585773e216fc7fa1f9ba2b68c9913405dc7809647326d33401f52f0e0db460643ccb536beede90a54da9795128025390f04ecc9fbf1acc9d7f89c2412b024150"} 14:19:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:19:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:19:45 INFO - Contents: 14:19:45 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bba9c5a49286c9655976bc121603e1f2d5078c743cecab9ad070f47528f796ff4ea7b93d686801305c2d07fa538840aea4ad8c1fe5789761b688d8e52f0a5942", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b0dd3327cf48e49e1ae7c463742b8317bfab24020ceabacf98fc2479454ac8e04755c98eaf1176509c55d563ab944ef12d024cc187e75250b78b90e4a4a7a0e5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/585773e216fc7fa1f9ba2b68c9913405dc7809647326d33401f52f0e0db460643ccb536beede90a54da9795128025390f04ecc9fbf1acc9d7f89c2412b024150"} 14:19:45 INFO - Running post-run listener: copy_logs_to_upload_dir 14:19:45 INFO - Copying logs to upload dir... 14:19:45 INFO - mkdir: /builds/slave/test/build/upload/logs 14:19:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.783892 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-10-09 14:19:45.220306) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-09 14:19:45.223928) ========= 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.QbhLxyOo7A/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.HA6NdCup4d/Listeners TMPDIR=/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/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/Firefox/sha512/bba9c5a49286c9655976bc121603e1f2d5078c743cecab9ad070f47528f796ff4ea7b93d686801305c2d07fa538840aea4ad8c1fe5789761b688d8e52f0a5942", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b0dd3327cf48e49e1ae7c463742b8317bfab24020ceabacf98fc2479454ac8e04755c98eaf1176509c55d563ab944ef12d024cc187e75250b78b90e4a4a7a0e5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/585773e216fc7fa1f9ba2b68c9913405dc7809647326d33401f52f0e0db460643ccb536beede90a54da9795128025390f04ecc9fbf1acc9d7f89c2412b024150"} build_url:https://queue.taskcluster.net/v1/task/M9pOvnTyRRS0-6QWyPwEvA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011071 build_url: 'https://queue.taskcluster.net/v1/task/M9pOvnTyRRS0-6QWyPwEvA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bba9c5a49286c9655976bc121603e1f2d5078c743cecab9ad070f47528f796ff4ea7b93d686801305c2d07fa538840aea4ad8c1fe5789761b688d8e52f0a5942", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b0dd3327cf48e49e1ae7c463742b8317bfab24020ceabacf98fc2479454ac8e04755c98eaf1176509c55d563ab944ef12d024cc187e75250b78b90e4a4a7a0e5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/585773e216fc7fa1f9ba2b68c9913405dc7809647326d33401f52f0e0db460643ccb536beede90a54da9795128025390f04ecc9fbf1acc9d7f89c2412b024150"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-09 14:19:45.260670) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-09 14:19:45.261059) ========= 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.QbhLxyOo7A/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.HA6NdCup4d/Listeners TMPDIR=/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/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.005176 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-09 14:19:45.310531) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-09 14:19:45.310921) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-09 14:19:45.311311) ========= ========= Total master_lag: 0.26 =========