builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0341 starttime: 1478365273.89 results: success (0) buildid: 20161105085321 builduid: d14bf844f48f49898f2f170aeaabfcb4 revision: 143ac19c32251f3cdbef47c7d1998fc870762b19 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-05 10:01:13.888371) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-05 10:01:13.888811) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-05 10:01:13.889095) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-05 10:01:14.113920) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-05 10:01:14.114197) ========= 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.bWsIxUsfhY/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.TT6j2k2N5K/Listeners TMPDIR=/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-11-05 10:01:14-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 43.0M=0s 2016-11-05 10:01:14 (43.0 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.680000 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-05 10:01:14.822748) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-05 10:01:14.823077) ========= 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.bWsIxUsfhY/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.TT6j2k2N5K/Listeners TMPDIR=/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/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.022854 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-05 10:01:14.872053) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-05 10:01:14.872363) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 143ac19c32251f3cdbef47c7d1998fc870762b19 --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 143ac19c32251f3cdbef47c7d1998fc870762b19 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.bWsIxUsfhY/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.TT6j2k2N5K/Listeners TMPDIR=/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-11-05 10:01:14,962 truncating revision to first 12 chars 2016-11-05 10:01:14,962 Setting DEBUG logging. 2016-11-05 10:01:14,963 attempt 1/10 2016-11-05 10:01:14,963 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/143ac19c3225?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-05 10:01:15,925 unpacking tar archive at: mozilla-central-143ac19c3225/testing/mozharness/ program finished with exit code 0 elapsedTime=1.230520 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-05 10:01:16.125159) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-05 10:01:16.125504) ========= script_repo_revision: 143ac19c32251f3cdbef47c7d1998fc870762b19 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-05 10:01:16.125940) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-05 10:01:16.126240) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-05 10:01:16.147818) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-11-05 10:01:16.148173) ========= /tools/buildbot/bin/python -u 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', '-u', '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.bWsIxUsfhY/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.TT6j2k2N5K/Listeners TMPDIR=/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/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 10:01:16 INFO - MultiFileLogger online at 20161105 10:01:16 in /builds/slave/test 10:01:16 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 10:01:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:01:16 INFO - {'append_to_log': False, 10:01:16 INFO - 'base_work_dir': '/builds/slave/test', 10:01:16 INFO - 'blob_upload_branch': 'Firefox', 10:01:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:01:16 INFO - 'branch': 'Firefox', 10:01:16 INFO - 'buildbot_json_path': 'buildprops.json', 10:01:16 INFO - 'config_files': ('talos/mac_config.py',), 10:01:16 INFO - 'default_actions': ('clobber', 10:01:16 INFO - 'read-buildbot-config', 10:01:16 INFO - 'download-and-extract', 10:01:16 INFO - 'populate-webroot', 10:01:16 INFO - 'create-virtualenv', 10:01:16 INFO - 'install', 10:01:16 INFO - 'run-tests'), 10:01:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:01:16 INFO - 'download_minidump_stackwalk': True, 10:01:16 INFO - 'download_symbols': 'ondemand', 10:01:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:01:16 INFO - 'tooltool.py': '/tools/tooltool.py', 10:01:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:01:16 INFO - '/tools/misc-python/virtualenv.py')}, 10:01:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:01:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:01:16 INFO - 'installer_path': 'installer.exe', 10:01:16 INFO - 'log_level': 'info', 10:01:16 INFO - 'log_name': 'talos', 10:01:16 INFO - 'log_to_console': True, 10:01:16 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:01:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:01:16 INFO - 'opt_config_files': (), 10:01:16 INFO - 'pip_index': False, 10:01:16 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:01:16 INFO - 'cmd': ('bash', 10:01:16 INFO - '-c', 10:01:16 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:01:16 INFO - 'enabled': True, 10:01:16 INFO - 'halt_on_failure': False, 10:01:16 INFO - 'name': 'check_screen_resolution'},), 10:01:16 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:01:16 INFO - 'cmd': ('bash', 10:01:16 INFO - '-c', 10:01:16 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:01:16 INFO - 'enabled': True, 10:01:16 INFO - 'halt_on_failure': False, 10:01:16 INFO - 'name': 'check_screen_resolution'},), 10:01:16 INFO - 'run_cmd_checks_enabled': True, 10:01:16 INFO - 'sps_profile': False, 10:01:16 INFO - 'sps_profile_interval': 0, 10:01:16 INFO - 'suite': 'dromaeojs-e10s', 10:01:16 INFO - 'system_bits': '32', 10:01:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:01:16 INFO - 'title': 't-yosemite-r7-0341', 10:01:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:01:16 INFO - 'use_talos_json': True, 10:01:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:01:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:01:16 INFO - 'work_dir': 'build'} 10:01:16 INFO - [mozharness: 2016-11-05 17:01:16.351038Z] Running clobber step. 10:01:16 INFO - Running pre-action listener: _resource_record_pre_action 10:01:16 INFO - Running main action method: clobber 10:01:16 INFO - rmtree: /builds/slave/test/build 10:01:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:01:18 INFO - Running post-action listener: _resource_record_post_action 10:01:18 INFO - [mozharness: 2016-11-05 17:01:18.498971Z] Finished clobber step (success) 10:01:18 INFO - [mozharness: 2016-11-05 17:01:18.499106Z] Running read-buildbot-config step. 10:01:18 INFO - Running pre-action listener: _resource_record_pre_action 10:01:18 INFO - Running main action method: read_buildbot_config 10:01:18 INFO - Using buildbot properties: 10:01:18 INFO - { 10:01:18 INFO - "project": "", 10:01:18 INFO - "product": "firefox", 10:01:18 INFO - "script_repo_revision": "production", 10:01:18 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 10:01:18 INFO - "repository": "", 10:01:18 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 10:01:18 INFO - "buildid": "20161105085321", 10:01:18 INFO - "pgo_build": "False", 10:01:18 INFO - "basedir": "/builds/slave/test", 10:01:18 INFO - "buildnumber": 8, 10:01:18 INFO - "slavename": "t-yosemite-r7-0341", 10:01:18 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 10:01:18 INFO - "platform": "yosemite_r7", 10:01:18 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 10:01:18 INFO - "branch": "mozilla-central", 10:01:18 INFO - "repo_path": "mozilla-central", 10:01:18 INFO - "revision": "143ac19c32251f3cdbef47c7d1998fc870762b19", 10:01:18 INFO - "stage_platform": "macosx64", 10:01:18 INFO - "builduid": "d14bf844f48f49898f2f170aeaabfcb4", 10:01:18 INFO - "slavebuilddir": "test" 10:01:18 INFO - } 10:01:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/c6Sy8-ibRsmMJ1f2aTyDRA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 10:01:18 INFO - Running post-action listener: _resource_record_post_action 10:01:18 INFO - [mozharness: 2016-11-05 17:01:18.502447Z] Finished read-buildbot-config step (success) 10:01:18 INFO - [mozharness: 2016-11-05 17:01:18.502609Z] Running download-and-extract step. 10:01:18 INFO - Running pre-action listener: _resource_record_pre_action 10:01:18 INFO - Running main action method: download_and_extract 10:01:18 INFO - mkdir: /builds/slave/test/build/tests 10:01:18 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')]} 10:01:18 INFO - trying https://queue.taskcluster.net/v1/task/c6Sy8-ibRsmMJ1f2aTyDRA/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 10:01:18 INFO - Downloading https://queue.taskcluster.net/v1/task/c6Sy8-ibRsmMJ1f2aTyDRA/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 10:01:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/c6Sy8-ibRsmMJ1f2aTyDRA/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 10:01:20 INFO - Downloaded 1199 bytes. 10:01:20 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 10:01:20 INFO - Using the following test package requirements: 10:01:20 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 10:01:20 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 10:01:20 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 10:01:20 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 10:01:20 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 10:01:20 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 10:01:20 INFO - u'jsshell-mac.zip'], 10:01:20 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 10:01:20 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 10:01:20 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 10:01:20 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 10:01:20 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 10:01:20 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 10:01:20 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 10:01:20 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 10:01:20 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 10:01:20 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 10:01:20 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 10:01:20 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 10:01:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/c6Sy8-ibRsmMJ1f2aTyDRA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 10:01:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/c6Sy8-ibRsmMJ1f2aTyDRA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:01:20 INFO - Fetch https://queue.taskcluster.net/v1/task/c6Sy8-ibRsmMJ1f2aTyDRA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 10:01:20 INFO - Http code: 200 10:01:20 INFO - via: 1.1 bfc29822e21ecc352f71dce83e06ab74.cloudfront.net (CloudFront) 10:01:20 INFO - x-amz-cf-id: Kq2usiJjmI1cCqK9-91HzLnk3q_7NsgRhAQ9mZs-zrQJeyUbDL33WQ== 10:01:20 INFO - x-amz-version-id: apChnqt3EmNIEekNzWz0zR5l9HUVOzhL 10:01:21 INFO - Expected file size: 16295754 10:01:21 INFO - Obtained file size: 16295754 10:01:27 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 10:01:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/c6Sy8-ibRsmMJ1f2aTyDRA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 10:01:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/c6Sy8-ibRsmMJ1f2aTyDRA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:01:27 INFO - Fetch https://queue.taskcluster.net/v1/task/c6Sy8-ibRsmMJ1f2aTyDRA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 10:01:28 INFO - Http code: 200 10:01:28 INFO - via: 1.1 d897b81191cbfd68a1b6fc44f98c52b0.cloudfront.net (CloudFront) 10:01:28 INFO - x-amz-cf-id: 9zPcEk_l68IlOvfIqA0ZZGJEUxtDlXUpulgdBk7lpn1yXyQwxjdNkQ== 10:01:28 INFO - x-amz-version-id: apChnqt3EmNIEekNzWz0zR5l9HUVOzhL 10:01:28 INFO - Expected file size: 16295754 10:01:28 INFO - Obtained file size: 16295754 10:01:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/c6Sy8-ibRsmMJ1f2aTyDRA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 10:01:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/c6Sy8-ibRsmMJ1f2aTyDRA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 10:01:34 INFO - Fetch https://queue.taskcluster.net/v1/task/c6Sy8-ibRsmMJ1f2aTyDRA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 10:01:35 INFO - Http code: 200 10:01:35 INFO - via: 1.1 37af14ee951b12568cf1cc160d08abe6.cloudfront.net (CloudFront) 10:01:35 INFO - x-amz-cf-id: wVykvcLjPagLmHp4uneNa2SolU0RrWfsaeUNATpQ9SL_uYqw66r9Bw== 10:01:35 INFO - x-amz-version-id: w_xwKCasUhz0_OeG.UpViwBX9ro6kHsw 10:01:35 INFO - Expected file size: 14409038 10:01:35 INFO - Obtained file size: 14409038 10:01:35 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')]} 10:01:35 INFO - trying https://queue.taskcluster.net/v1/task/c6Sy8-ibRsmMJ1f2aTyDRA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 10:01:35 INFO - Downloading https://queue.taskcluster.net/v1/task/c6Sy8-ibRsmMJ1f2aTyDRA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 10:01:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/c6Sy8-ibRsmMJ1f2aTyDRA/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 10:01:39 INFO - Downloaded 111213920 bytes. 10:01:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/c6Sy8-ibRsmMJ1f2aTyDRA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 10:01:39 INFO - mkdir: /builds/slave/test/properties 10:01:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:01:39 INFO - Writing to file /builds/slave/test/properties/build_url 10:01:39 INFO - Contents: 10:01:39 INFO - build_url:https://queue.taskcluster.net/v1/task/c6Sy8-ibRsmMJ1f2aTyDRA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 10:01:40 INFO - Running post-action listener: _resource_record_post_action 10:01:40 INFO - Running post-action listener: set_extra_try_arguments 10:01:40 INFO - [mozharness: 2016-11-05 17:01:40.126479Z] Finished download-and-extract step (success) 10:01:40 INFO - [mozharness: 2016-11-05 17:01:40.126607Z] Running populate-webroot step. 10:01:40 INFO - Running pre-action listener: _resource_record_pre_action 10:01:40 INFO - Running main action method: populate_webroot 10:01:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:01:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:01:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:01:40 INFO - '--tppagecycles', 10:01:40 INFO - '7'], 10:01:40 INFO - 'tests': ['tsvgm']}}, 10:01:40 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:01:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:01:40 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:01:40 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:01:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:01:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:01:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:01:40 INFO - 'talos_options': ['--disable-e10s'], 10:01:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:01:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:01:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:01:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:01:40 INFO - 'talos_options': ['--disable-e10s'], 10:01:40 INFO - 'tests': ['damp', 'tps']}, 10:01:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:01:40 INFO - 'tests': ['damp', 'tps']}, 10:01:40 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:01:40 INFO - 'tests': ['dromaeo_dom']}, 10:01:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:01:40 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:01:40 INFO - 'tests': ['basic_compositor_video']}, 10:01:40 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:01:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:01:40 INFO - 'tests': ['a11yr', 10:01:40 INFO - 'ts_paint', 10:01:40 INFO - 'tpaint', 10:01:40 INFO - 'sessionrestore', 10:01:40 INFO - 'sessionrestore_no_auto_restore', 10:01:40 INFO - 'tabpaint']}, 10:01:40 INFO - 'other-e10s': {'tests': ['a11yr', 10:01:40 INFO - 'ts_paint', 10:01:40 INFO - 'tpaint', 10:01:40 INFO - 'sessionrestore', 10:01:40 INFO - 'sessionrestore_no_auto_restore', 10:01:40 INFO - 'tabpaint']}, 10:01:40 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:01:40 INFO - 'ts_paint', 10:01:40 INFO - 'tpaint', 10:01:40 INFO - 'sessionrestore', 10:01:40 INFO - 'sessionrestore_no_auto_restore', 10:01:40 INFO - 'tabpaint']}, 10:01:40 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:01:40 INFO - 'ts_paint', 10:01:40 INFO - 'tpaint', 10:01:40 INFO - 'sessionrestore', 10:01:40 INFO - 'sessionrestore_no_auto_restore', 10:01:40 INFO - 'tabpaint']}, 10:01:40 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:01:40 INFO - 'tests': ['a11yr', 10:01:40 INFO - 'ts_paint', 10:01:40 INFO - 'tpaint', 10:01:40 INFO - 'sessionrestore', 10:01:40 INFO - 'sessionrestore_no_auto_restore', 10:01:40 INFO - 'tabpaint']}, 10:01:40 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:01:40 INFO - 'tests': ['a11yr', 10:01:40 INFO - 'ts_paint', 10:01:40 INFO - 'tpaint', 10:01:40 INFO - 'sessionrestore', 10:01:40 INFO - 'sessionrestore_no_auto_restore', 10:01:40 INFO - 'tabpaint']}, 10:01:40 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:01:40 INFO - 'tests': ['tsvgx', 10:01:40 INFO - 'tsvgr_opacity', 10:01:40 INFO - 'tart', 10:01:40 INFO - 'tscrollx', 10:01:40 INFO - 'cart']}, 10:01:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:01:40 INFO - 'tsvgr_opacity', 10:01:40 INFO - 'tart', 10:01:40 INFO - 'tscrollx', 10:01:40 INFO - 'cart']}, 10:01:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:01:40 INFO - 'talos_options': ['--disable-e10s'], 10:01:40 INFO - 'tests': ['tp5o']}, 10:01:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:01:40 INFO - 'tests': ['tp5o']}, 10:01:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:01:40 INFO - 'talos_options': ['--disable-e10s', 10:01:40 INFO - '--xperf_path', 10:01:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:01:40 INFO - 'tests': ['tp5n']}, 10:01:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:01:40 INFO - 'talos_options': ['--xperf_path', 10:01:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:01:40 INFO - 'tests': ['tp5n']}}, 10:01:40 INFO - 'talos.zip': {'path': '', 10:01:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:01:40 INFO - Running post-action listener: _resource_record_post_action 10:01:40 INFO - [mozharness: 2016-11-05 17:01:40.145208Z] Finished populate-webroot step (success) 10:01:40 INFO - [mozharness: 2016-11-05 17:01:40.145353Z] Running create-virtualenv step. 10:01:40 INFO - Running pre-action listener: _resource_record_pre_action 10:01:40 INFO - Running main action method: create_virtualenv 10:01:40 INFO - Creating virtualenv /builds/slave/test/build/venv 10:01:40 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 10:01:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:01:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:01:40 INFO - Using real prefix '/tools/python27' 10:01:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:01:40 INFO - Installing distribute.............................................................................................................................................................................................done. 10:01:43 INFO - Installing pip.................done. 10:01:43 INFO - Return code: 0 10:01:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:01:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:01:44 INFO - Reading from file tmpfile_stdout 10:01:44 INFO - Output received: 10:01:44 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) 10:01:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:01:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:01:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:01:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:01:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:01:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105730490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056a6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2d0d8baa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105544d30>, '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 0x10536adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10553cb20>, '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.bWsIxUsfhY/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.TT6j2k2N5K/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/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 10:01:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:01:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:01:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bWsIxUsfhY/Render', 10:01:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:01:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:01:44 INFO - 'HOME': '/Users/cltbld', 10:01:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:01:44 INFO - 'LOGNAME': 'cltbld', 10:01:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:01:44 INFO - 'MOZ_NO_REMOTE': '1', 10:01:44 INFO - 'NO_EM_RESTART': '1', 10:01:44 INFO - 'PAGER': '/bin/cat', 10:01:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:01:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:01:44 INFO - 'PWD': '/builds/slave/test', 10:01:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:01:44 INFO - 'SHELL': '/bin/bash', 10:01:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TT6j2k2N5K/Listeners', 10:01:44 INFO - 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/', 10:01:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:01:44 INFO - 'USER': 'cltbld', 10:01:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:01:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:01:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:01:44 INFO - 'XPC_FLAGS': '0x0', 10:01:44 INFO - 'XPC_SERVICE_NAME': '0', 10:01:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:01:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:01:44 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 10:01:44 INFO - Cleaning up... 10:01:44 INFO - Return code: 0 10:01:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:01:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:01:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:01:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:01:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:01:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x105730490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056a6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2d0d8baa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105544d30>, '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 0x10536adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10553cb20>, '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.bWsIxUsfhY/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.TT6j2k2N5K/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/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 10:01:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:01:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:01:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bWsIxUsfhY/Render', 10:01:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:01:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:01:44 INFO - 'HOME': '/Users/cltbld', 10:01:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:01:44 INFO - 'LOGNAME': 'cltbld', 10:01:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:01:44 INFO - 'MOZ_NO_REMOTE': '1', 10:01:44 INFO - 'NO_EM_RESTART': '1', 10:01:44 INFO - 'PAGER': '/bin/cat', 10:01:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:01:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:01:44 INFO - 'PWD': '/builds/slave/test', 10:01:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:01:44 INFO - 'SHELL': '/bin/bash', 10:01:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TT6j2k2N5K/Listeners', 10:01:44 INFO - 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/', 10:01:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:01:44 INFO - 'USER': 'cltbld', 10:01:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:01:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:01:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:01:44 INFO - 'XPC_FLAGS': '0x0', 10:01:44 INFO - 'XPC_SERVICE_NAME': '0', 10:01:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:01:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:01:44 INFO - Downloading/unpacking psutil>=3.1.1 10:01:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:01:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:01:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:01:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:01:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:01:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:01:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:01:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:01:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:01:48 INFO - Installing collected packages: psutil 10:01:48 INFO - Running setup.py install for psutil 10:01:48 INFO - building 'psutil._psutil_osx' extension 10:01:48 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 10:01:49 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 10:01:49 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 10:01:49 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 10:01:49 INFO - building 'psutil._psutil_posix' extension 10:01:49 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 10:01:49 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:01:49 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:01:49 INFO - ^ 10:01:49 INFO - 1 warning generated. 10:01:49 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 10:01:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:01:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:01:49 INFO - Successfully installed psutil 10:01:49 INFO - Cleaning up... 10:01:49 INFO - Return code: 0 10:01:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:01:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:01:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:01:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:01:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:01:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:49 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 0x105730490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056a6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2d0d8baa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105544d30>, '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 0x10536adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10553cb20>, '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.bWsIxUsfhY/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.TT6j2k2N5K/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/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 10:01:49 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 10:01:49 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 10:01:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bWsIxUsfhY/Render', 10:01:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:01:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:01:49 INFO - 'HOME': '/Users/cltbld', 10:01:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:01:49 INFO - 'LOGNAME': 'cltbld', 10:01:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:01:49 INFO - 'MOZ_NO_REMOTE': '1', 10:01:49 INFO - 'NO_EM_RESTART': '1', 10:01:49 INFO - 'PAGER': '/bin/cat', 10:01:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:01:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:01:49 INFO - 'PWD': '/builds/slave/test', 10:01:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:01:49 INFO - 'SHELL': '/bin/bash', 10:01:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TT6j2k2N5K/Listeners', 10:01:49 INFO - 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/', 10:01:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:01:49 INFO - 'USER': 'cltbld', 10:01:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:01:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:01:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:01:49 INFO - 'XPC_FLAGS': '0x0', 10:01:49 INFO - 'XPC_SERVICE_NAME': '0', 10:01:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:01:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:01:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:01:49 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 10:01:49 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 10:01:49 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 10:01:49 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 10:01:49 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 10:01:49 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 10:01:52 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:01:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:01:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:01:52 INFO - Installing collected packages: mozsystemmonitor 10:01:52 INFO - Running setup.py install for mozsystemmonitor 10:01:52 INFO - Successfully installed mozsystemmonitor 10:01:52 INFO - Cleaning up... 10:01:52 INFO - Return code: 0 10:01:52 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:01:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:01:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:01:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:01:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:01:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x105730490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056a6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2d0d8baa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105544d30>, '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 0x10536adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10553cb20>, '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.bWsIxUsfhY/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.TT6j2k2N5K/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/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 10:01:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:01:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:01:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bWsIxUsfhY/Render', 10:01:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:01:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:01:52 INFO - 'HOME': '/Users/cltbld', 10:01:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:01:52 INFO - 'LOGNAME': 'cltbld', 10:01:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:01:52 INFO - 'MOZ_NO_REMOTE': '1', 10:01:52 INFO - 'NO_EM_RESTART': '1', 10:01:52 INFO - 'PAGER': '/bin/cat', 10:01:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:01:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:01:52 INFO - 'PWD': '/builds/slave/test', 10:01:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:01:52 INFO - 'SHELL': '/bin/bash', 10:01:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TT6j2k2N5K/Listeners', 10:01:52 INFO - 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/', 10:01:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:01:52 INFO - 'USER': 'cltbld', 10:01:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:01:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:01:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:01:52 INFO - 'XPC_FLAGS': '0x0', 10:01:52 INFO - 'XPC_SERVICE_NAME': '0', 10:01:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:01:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:01:52 INFO - Downloading/unpacking jsonschema==2.5.1 10:01:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:01:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:01:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:01:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:01:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:01:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:01:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:01:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:01:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:01:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:01:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:01:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:01:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:01:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:01:55 INFO - Downloading functools32-3.2.3-2.tar.gz 10:01:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:01:55 INFO - warning: no files found matching '*.txt' 10:01:55 INFO - no previously-included directories found matching 'build' 10:01:55 INFO - no previously-included directories found matching 'dist' 10:01:55 INFO - no previously-included directories found matching '.git*' 10:01:55 INFO - Installing collected packages: jsonschema, functools32 10:01:55 INFO - Running setup.py install for functools32 10:01:56 INFO - warning: no files found matching '*.txt' 10:01:56 INFO - no previously-included directories found matching 'build' 10:01:56 INFO - no previously-included directories found matching 'dist' 10:01:56 INFO - no previously-included directories found matching '.git*' 10:01:56 INFO - Successfully installed jsonschema functools32 10:01:56 INFO - Cleaning up... 10:01:56 INFO - Return code: 0 10:01:56 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:01:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:01:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:01:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:01:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:01:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x105730490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056a6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2d0d8baa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105544d30>, '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 0x10536adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10553cb20>, '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.bWsIxUsfhY/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.TT6j2k2N5K/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/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 10:01:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 10:01:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 10:01:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bWsIxUsfhY/Render', 10:01:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:01:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:01:56 INFO - 'HOME': '/Users/cltbld', 10:01:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:01:56 INFO - 'LOGNAME': 'cltbld', 10:01:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:01:56 INFO - 'MOZ_NO_REMOTE': '1', 10:01:56 INFO - 'NO_EM_RESTART': '1', 10:01:56 INFO - 'PAGER': '/bin/cat', 10:01:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:01:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:01:56 INFO - 'PWD': '/builds/slave/test', 10:01:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:01:56 INFO - 'SHELL': '/bin/bash', 10:01:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TT6j2k2N5K/Listeners', 10:01:56 INFO - 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/', 10:01:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:01:56 INFO - 'USER': 'cltbld', 10:01:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:01:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:01:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:01:56 INFO - 'XPC_FLAGS': '0x0', 10:01:56 INFO - 'XPC_SERVICE_NAME': '0', 10:01:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:01:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:01:56 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:01:56 INFO - Cleaning up... 10:01:56 INFO - Return code: 0 10:01:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:01:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:01:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:01:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:01:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:01:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x105730490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056a6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2d0d8baa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105544d30>, '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 0x10536adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10553cb20>, '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.bWsIxUsfhY/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.TT6j2k2N5K/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/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 10:01:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:01:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:01:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bWsIxUsfhY/Render', 10:01:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:01:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:01:56 INFO - 'HOME': '/Users/cltbld', 10:01:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:01:56 INFO - 'LOGNAME': 'cltbld', 10:01:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:01:56 INFO - 'MOZ_NO_REMOTE': '1', 10:01:56 INFO - 'NO_EM_RESTART': '1', 10:01:56 INFO - 'PAGER': '/bin/cat', 10:01:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:01:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:01:56 INFO - 'PWD': '/builds/slave/test', 10:01:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:01:56 INFO - 'SHELL': '/bin/bash', 10:01:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TT6j2k2N5K/Listeners', 10:01:56 INFO - 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/', 10:01:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:01:56 INFO - 'USER': 'cltbld', 10:01:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:01:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:01:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:01:56 INFO - 'XPC_FLAGS': '0x0', 10:01:56 INFO - 'XPC_SERVICE_NAME': '0', 10:01:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:01:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:01:56 INFO - Downloading/unpacking blobuploader==1.2.4 10:01:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:01:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:01:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:01:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:01:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:01:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:01:59 INFO - Downloading blobuploader-1.2.4.tar.gz 10:01:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:01:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:01:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:01:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:01:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:01:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:01:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:01:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:01:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:02:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:02: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 10:02: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 10:02: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 10:02: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 10:02: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 10:02: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 10:02:00 INFO - Downloading docopt-0.6.1.tar.gz 10:02:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:02:00 INFO - Installing collected packages: blobuploader, requests, docopt 10:02:00 INFO - Running setup.py install for blobuploader 10:02:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:02:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:02:00 INFO - Running setup.py install for requests 10:02:01 INFO - Running setup.py install for docopt 10:02:01 INFO - Successfully installed blobuploader requests docopt 10:02:01 INFO - Cleaning up... 10:02:01 INFO - Return code: 0 10:02:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:02:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:02:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:02:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:01 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 0x105730490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056a6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2d0d8baa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105544d30>, '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 0x10536adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10553cb20>, '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.bWsIxUsfhY/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.TT6j2k2N5K/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/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 10:02:01 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 10:02:01 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 10:02:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bWsIxUsfhY/Render', 10:02:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:02:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:02:01 INFO - 'HOME': '/Users/cltbld', 10:02:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:02:01 INFO - 'LOGNAME': 'cltbld', 10:02:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:01 INFO - 'MOZ_NO_REMOTE': '1', 10:02:01 INFO - 'NO_EM_RESTART': '1', 10:02:01 INFO - 'PAGER': '/bin/cat', 10:02:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:02:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:01 INFO - 'PWD': '/builds/slave/test', 10:02:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:02:01 INFO - 'SHELL': '/bin/bash', 10:02:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TT6j2k2N5K/Listeners', 10:02:01 INFO - 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/', 10:02:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:02:01 INFO - 'USER': 'cltbld', 10:02:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:02:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:02:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:01 INFO - 'XPC_FLAGS': '0x0', 10:02:01 INFO - 'XPC_SERVICE_NAME': '0', 10:02:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:02:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:02:01 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-9q0FrS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:02:01 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-MlEBYy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:02:01 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-qyvsBG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:02:01 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-MS_YVT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:02:02 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-6H3CRA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:02:02 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-1bZHJa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:02:02 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-aUH7p_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:02:02 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-90yalb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:02:02 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-1QieSN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:02:02 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-QNnK7A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:02:02 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-u7pVq1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:02:02 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-34A1ku-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:02:02 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-JQBaCs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:02:02 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-v9QmqP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:02:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:02:03 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-gY0iaa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:02:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:02:03 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-gcXyXS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:02:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:02:03 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-ZlNeuI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:02:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:02:03 INFO - Running setup.py install for manifestparser 10:02:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:02:03 INFO - Running setup.py install for mozcrash 10:02:03 INFO - Running setup.py install for mozdebug 10:02:03 INFO - Running setup.py install for mozdevice 10:02:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:02:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:02:04 INFO - Running setup.py install for mozfile 10:02:04 INFO - Running setup.py install for mozhttpd 10:02:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:02:04 INFO - Running setup.py install for mozinfo 10:02:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:02:04 INFO - Running setup.py install for mozInstall 10:02:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:02:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:02:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:02:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:02:04 INFO - Running setup.py install for mozleak 10:02:04 INFO - Running setup.py install for mozlog 10:02:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:02:04 INFO - Running setup.py install for moznetwork 10:02:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:02:05 INFO - Running setup.py install for mozprocess 10:02:05 INFO - Running setup.py install for mozprofile 10:02:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:02:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:02:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:02:05 INFO - Running setup.py install for mozrunner 10:02:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:02:05 INFO - Running setup.py install for mozscreenshot 10:02:05 INFO - Running setup.py install for moztest 10:02:05 INFO - Running setup.py install for mozversion 10:02:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:02:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:02:05 INFO - Cleaning up... 10:02:05 INFO - Return code: 0 10:02:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:02: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')]} 10:02:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02: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')]} 10:02:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:05 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 0x105730490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056a6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2d0d8baa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105544d30>, '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 0x10536adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10553cb20>, '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.bWsIxUsfhY/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.TT6j2k2N5K/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/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 10:02:05 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 10:02:05 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 10:02:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bWsIxUsfhY/Render', 10:02:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:02:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:02:05 INFO - 'HOME': '/Users/cltbld', 10:02:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:02:05 INFO - 'LOGNAME': 'cltbld', 10:02:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:05 INFO - 'MOZ_NO_REMOTE': '1', 10:02:05 INFO - 'NO_EM_RESTART': '1', 10:02:05 INFO - 'PAGER': '/bin/cat', 10:02:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:02:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:05 INFO - 'PWD': '/builds/slave/test', 10:02:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:02:05 INFO - 'SHELL': '/bin/bash', 10:02:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TT6j2k2N5K/Listeners', 10:02:05 INFO - 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/', 10:02:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:02:05 INFO - 'USER': 'cltbld', 10:02:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:02:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:02:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:05 INFO - 'XPC_FLAGS': '0x0', 10:02:05 INFO - 'XPC_SERVICE_NAME': '0', 10:02:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:02:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:02:06 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-HjkkO3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:02:06 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)) 10:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:02:06 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-SQ8Z35-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:02:06 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)) 10:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:02:06 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-7_2SM9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:02:06 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)) 10:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:02:06 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-F0kawX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:02:06 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)) 10:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:02:06 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-I5pL3W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:02:06 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)) 10:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:02:06 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-d1x9Ca-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:02:06 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)) 10:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:02:06 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-7KRHYf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:02:06 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)) 10:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:02:06 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-UZe4ky-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:02:07 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)) 10:02:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:02:07 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-gHkD5t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:02:07 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)) 10:02:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:02:07 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-FllHvj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:02:07 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)) 10:02:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:02:07 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-Ok56RL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:02:07 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)) 10:02:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:02:07 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-PGLo4R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:02:07 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)) 10:02:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:02:07 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-yPVBdx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:02:07 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)) 10:02:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:02:07 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-hr_9bO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:02:07 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)) 10:02:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:02:07 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-QocjoN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:02:07 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)) 10:02:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:02:07 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-Nw6u02-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:02:07 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)) 10:02:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:02:07 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-L_H53t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:02:08 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)) 10:02:08 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)) 10:02:08 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)) 10:02:08 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)) 10:02:08 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)) 10:02:08 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)) 10:02:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:02: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 10:02: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 10:02: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 10:02: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 10:02: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 10:02: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 10:02:10 INFO - Downloading blessings-1.6.tar.gz 10:02:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:02:10 INFO - Installing collected packages: blessings 10:02:10 INFO - Running setup.py install for blessings 10:02:10 INFO - Successfully installed blessings 10:02:10 INFO - Cleaning up... 10:02:10 INFO - Return code: 0 10:02:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:02:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:02:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:02:11 INFO - Reading from file tmpfile_stdout 10:02:11 INFO - Current package versions: 10:02:11 INFO - blessings == 1.6 10:02:11 INFO - blobuploader == 1.2.4 10:02:11 INFO - docopt == 0.6.1 10:02:11 INFO - functools32 == 3.2.3-2 10:02:11 INFO - jsonschema == 2.5.1 10:02:11 INFO - manifestparser == 1.1 10:02:11 INFO - mozInstall == 1.12 10:02:11 INFO - mozcrash == 0.17 10:02:11 INFO - mozdebug == 0.1 10:02:11 INFO - mozdevice == 0.48 10:02:11 INFO - mozfile == 1.2 10:02:11 INFO - mozhttpd == 0.7 10:02:11 INFO - mozinfo == 0.9 10:02:11 INFO - mozleak == 0.1 10:02:11 INFO - mozlog == 3.4 10:02:11 INFO - moznetwork == 0.27 10:02:11 INFO - mozprocess == 0.23 10:02:11 INFO - mozprofile == 0.28 10:02:11 INFO - mozrunner == 6.12 10:02:11 INFO - mozscreenshot == 0.1 10:02:11 INFO - mozsystemmonitor == 0.3 10:02:11 INFO - moztest == 0.7 10:02:11 INFO - mozversion == 1.4 10:02:11 INFO - psutil == 3.1.1 10:02:11 INFO - requests == 1.2.3 10:02:11 INFO - wsgiref == 0.1.2 10:02:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:02: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')]} 10:02:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02: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')]} 10:02:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:11 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 0x105730490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056a6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2d0d8baa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105544d30>, '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 0x10536adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10553cb20>, '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.bWsIxUsfhY/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.TT6j2k2N5K/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/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 10:02:11 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 10:02:11 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 10:02:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bWsIxUsfhY/Render', 10:02:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:02:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:02:11 INFO - 'HOME': '/Users/cltbld', 10:02:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:02:11 INFO - 'LOGNAME': 'cltbld', 10:02:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:11 INFO - 'MOZ_NO_REMOTE': '1', 10:02:11 INFO - 'NO_EM_RESTART': '1', 10:02:11 INFO - 'PAGER': '/bin/cat', 10:02:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:02:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:11 INFO - 'PWD': '/builds/slave/test', 10:02:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:02:11 INFO - 'SHELL': '/bin/bash', 10:02:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TT6j2k2N5K/Listeners', 10:02:11 INFO - 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/', 10:02:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:02:11 INFO - 'USER': 'cltbld', 10:02:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:02:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:02:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:11 INFO - 'XPC_FLAGS': '0x0', 10:02:11 INFO - 'XPC_SERVICE_NAME': '0', 10:02:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:02:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:11 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)) 10:02:11 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)) 10:02:11 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)) 10:02:11 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)) 10:02:11 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)) 10:02:11 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)) 10:02:11 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)) 10:02:11 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)) 10:02:11 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)) 10:02:11 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)) 10:02:11 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)) 10:02:11 INFO - Cleaning up... 10:02:11 INFO - Return code: 0 10:02:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:02: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')]} 10:02:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02: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')]} 10:02:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105730490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056a6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2d0d8baa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105544d30>, '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 0x10536adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10553cb20>, '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.bWsIxUsfhY/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.TT6j2k2N5K/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/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 10:02: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', 'jsonschema'] in /builds/slave/test/build 10:02: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 jsonschema 10:02:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bWsIxUsfhY/Render', 10:02:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:02:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:02:11 INFO - 'HOME': '/Users/cltbld', 10:02:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:02:11 INFO - 'LOGNAME': 'cltbld', 10:02:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:11 INFO - 'MOZ_NO_REMOTE': '1', 10:02:11 INFO - 'NO_EM_RESTART': '1', 10:02:11 INFO - 'PAGER': '/bin/cat', 10:02:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:02:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:11 INFO - 'PWD': '/builds/slave/test', 10:02:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:02:11 INFO - 'SHELL': '/bin/bash', 10:02:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TT6j2k2N5K/Listeners', 10:02:11 INFO - 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/', 10:02:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:02:11 INFO - 'USER': 'cltbld', 10:02:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:02:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:02:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:11 INFO - 'XPC_FLAGS': '0x0', 10:02:11 INFO - 'XPC_SERVICE_NAME': '0', 10:02:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:02:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:02:11 INFO - Cleaning up... 10:02:11 INFO - Return code: 0 10:02:11 INFO - Running post-action listener: _resource_record_post_action 10:02:11 INFO - Running post-action listener: _start_resource_monitoring 10:02:11 INFO - Starting resource monitoring. 10:02:11 INFO - [mozharness: 2016-11-05 17:02:11.758455Z] Finished create-virtualenv step (success) 10:02:11 INFO - [mozharness: 2016-11-05 17:02:11.759417Z] Running install step. 10:02:11 INFO - Running pre-action listener: _resource_record_pre_action 10:02:11 INFO - Running main action method: install 10:02:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:02:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:02:12 INFO - Reading from file tmpfile_stdout 10:02:12 INFO - Detecting whether we're running mozinstall >=1.0... 10:02:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:02:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:02:12 INFO - Reading from file tmpfile_stdout 10:02:12 INFO - Output received: 10:02:12 INFO - Usage: mozinstall [options] installer 10:02:12 INFO - Options: 10:02:12 INFO - -h, --help show this help message and exit 10:02:12 INFO - -d DEST, --destination=DEST 10:02:12 INFO - Directory to install application into. [default: 10:02:12 INFO - "/builds/slave/test"] 10:02:12 INFO - --app=APP Application being installed. [default: firefox] 10:02:12 INFO - mkdir: /builds/slave/test/build/application 10:02:12 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'] 10:02:12 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 10:02:46 INFO - Reading from file tmpfile_stdout 10:02:46 INFO - Output received: 10:02:46 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 10:02:46 INFO - Running post-action listener: _resource_record_post_action 10:02:46 INFO - [mozharness: 2016-11-05 17:02:46.200222Z] Finished install step (success) 10:02:46 INFO - [mozharness: 2016-11-05 17:02:46.200332Z] Running run-tests step. 10:02:46 INFO - Running pre-action listener: _resource_record_pre_action 10:02:46 INFO - Running main action method: run_tests 10:02:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:02:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:02:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:02:46 INFO - 2016-11-05 10:02:46.212 screenresolution[1655:9676] starting screenresolution argv=screenresolution get 10:02:46 INFO - 2016-11-05 10:02:46.215 screenresolution[1655:9676] Display 0: 1600x1200x32@60 10:02:46 INFO - 2016-11-05 10:02:46.220 screenresolution[1656:9678] starting screenresolution argv=screenresolution list 10:02:46 INFO - Available Modes on Display 0 10:02:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:02:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:02:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:02:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:02:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:02:46 INFO - Intel Iris: 10:02:46 INFO - Chipset Model: Intel Iris 10:02:46 INFO - Type: GPU 10:02:46 INFO - Bus: Built-In 10:02:46 INFO - VRAM (Dynamic, Max): 1536 MB 10:02:46 INFO - Vendor: Intel (0x8086) 10:02:46 INFO - Device ID: 0x0a2e 10:02:46 INFO - Revision ID: 0x0009 10:02:46 INFO - Displays: 10:02:46 INFO - Display: 10:02:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:02:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:02:46 INFO - Display Serial Number: 1600x1200 60 10:02:46 INFO - Main Display: Yes 10:02:46 INFO - Mirror: Off 10:02:46 INFO - Online: Yes 10:02:46 INFO - Rotation: Supported 10:02:46 INFO - Return code: 0 10:02:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:02:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:02:46 INFO - Python 2.7.3 10:02:46 INFO - Return code: 0 10:02:46 INFO - grabbing minidump binary from tooltool 10:02:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:02:46 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 0x105544d30>, '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 0x10536adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10553cb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:02:46 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 10:02:46 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 10:02:46 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 10:02:46 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:02:46 INFO - Return code: 0 10:02:46 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:02:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:02:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:02:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:02:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:02:46 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/c6Sy8-ibRsmMJ1f2aTyDRA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0341', '--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 10:02:46 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/c6Sy8-ibRsmMJ1f2aTyDRA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0341 --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 10:02:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bWsIxUsfhY/Render', 10:02:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:02:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:02:46 INFO - 'HOME': '/Users/cltbld', 10:02:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:02:46 INFO - 'LOGNAME': 'cltbld', 10:02:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:02:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:02:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:46 INFO - 'MOZ_NO_REMOTE': '1', 10:02:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:02:46 INFO - 'NO_EM_RESTART': '1', 10:02:46 INFO - 'PAGER': '/bin/cat', 10:02:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:02:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:46 INFO - 'PWD': '/builds/slave/test', 10:02:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:02:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:02:46 INFO - 'SHELL': '/bin/bash', 10:02:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TT6j2k2N5K/Listeners', 10:02:46 INFO - 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/', 10:02:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:02:46 INFO - 'USER': 'cltbld', 10:02:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:02:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:02:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:46 INFO - 'XPC_FLAGS': '0x0', 10:02:46 INFO - 'XPC_SERVICE_NAME': '0', 10:02:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:02:46 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/c6Sy8-ibRsmMJ1f2aTyDRA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0341', '--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 10:02:46 INFO - mozversion application_buildid: 20161105085321 10:02:46 INFO - mozversion application_changeset: 143ac19c32251f3cdbef47c7d1998fc870762b19 10:02:46 INFO - mozversion application_display_name: Nightly 10:02:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:02:46 INFO - mozversion application_name: Firefox 10:02:46 INFO - mozversion application_remotingname: firefox 10:02:46 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:02:46 INFO - mozversion application_vendor: Mozilla 10:02:46 INFO - mozversion application_version: 52.0a1 10:02:46 INFO - mozversion platform_buildid: 20161105085321 10:02:46 INFO - mozversion platform_changeset: 143ac19c32251f3cdbef47c7d1998fc870762b19 10:02:46 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:02:46 INFO - mozversion platform_version: 52.0a1 10:02:46 INFO - using testdate: 1478365366 10:02:46 INFO - actual date: 1478365366 10:02:46 INFO - starting webserver on 'localhost:49274' 10:02:46 INFO - SUITE-START | Running 2 tests 10:02:46 INFO - TEST-START | dromaeo_css 10:02:46 INFO - operating with platform_type : mac_ 10:02:46 INFO - Initialising browser for dromaeo_css test... 10:02:46 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/tmpQET_54/profile http://localhost:49274/getInfo.html) 10:02:49 INFO - PROCESS | 1666 | 2016-11-05 10:02:49.783 plugin-container[1668:9857] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4c43, name = 'com.apple.tsm.portname' 10:02:49 INFO - PROCESS | 1666 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:02:49 INFO - PROCESS | 1666 | 2016-11-05 10:02:49.786 plugin-container[1668:9857] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4c47, name = 'com.apple.CFPasteboardClient' 10:02:49 INFO - PROCESS | 1666 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:02:49 INFO - PROCESS | 1666 | 2016-11-05 10:02:49.786 plugin-container[1668:9857] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:02:49 INFO - PROCESS | 1666 | __metrics Screen width/height:1600/1200 10:02:49 INFO - PROCESS | 1666 | colorDepth:24 10:02:49 INFO - PROCESS | 1666 | Browser inner width/height: 1024/689 10:02:49 INFO - PROCESS | 1666 | __metrics 10:02:49 ERROR - PROCESS | 1666 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3158: TypeError: this.tabs is undefined 10:02:50 INFO - TEST-INFO | 1666: exit 0 10:02:50 INFO - Browser initialized. 10:02:50 INFO - Running cycle 1/1 for dromaeo_css test... 10:02:50 INFO - TEST-INFO | started process 1670 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/tmpQET_54/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:02:53 INFO - PROCESS | 1670 | 2016-11-05 10:02:53.304 plugin-container[1671:9984] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x863f, name = 'com.apple.tsm.portname' 10:02:53 INFO - PROCESS | 1670 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:02:53 INFO - PROCESS | 1670 | 2016-11-05 10:02:53.306 plugin-container[1671:9984] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b0b, name = 'com.apple.CFPasteboardClient' 10:02:53 INFO - PROCESS | 1670 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:02:53 INFO - PROCESS | 1670 | 2016-11-05 10:02:53.306 plugin-container[1671:9984] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:03:02 INFO - PROCESS | 1670 | RSS: Main: 238858240 10:03:02 INFO - PROCESS | 1670 | 10:03:52 INFO - PROCESS | 1670 | 1478365432427 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] 10:06:04 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49274/tests/dromaeo/cssquery-ext.html) 10:06:06 INFO - PROCESS | 1670 | RSS: Main: 253042688 10:06:06 INFO - PROCESS | 1670 | 10:09:08 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-ext.html (next: http://localhost:49274/tests/dromaeo/cssquery-jquery.html) 10:09:08 INFO - PROCESS | 1670 | RSS: Main: 261877760 10:09:08 INFO - PROCESS | 1670 | 10:12:10 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49274/tests/dromaeo/cssquery-mootools.html) 10:12:11 INFO - PROCESS | 1670 | RSS: Main: 266170368 10:12:11 INFO - PROCESS | 1670 | 10:15:13 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49274/tests/dromaeo/cssquery-prototype.html) 10:15:13 INFO - PROCESS | 1670 | RSS: Main: 264749056 10:15:13 INFO - PROCESS | 1670 | 10:18:16 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49274/tests/dromaeo/cssquery-yui.html) 10:18:17 INFO - PROCESS | 1670 | RSS: Main: 269950976 10:18:17 INFO - PROCESS | 1670 | 10:21:20 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-yui.html (next: http://localhost:49274/tests/dromaeo/cssquery-dojo.html) 10:21:20 INFO - PROCESS | 1670 | RSS: Main: 272650240 10:21:20 INFO - PROCESS | 1670 | 10:21:20 INFO - PROCESS | 1670 | __start_tp_report 10:21:20 INFO - PROCESS | 1670 | _x_x_mozilla_page_load 10:21:20 INFO - PROCESS | 1670 | _x_x_mozilla_page_load_details 10:21:20 INFO - PROCESS | 1670 | |i|pagename|runs| 10:21:20 INFO - PROCESS | 1670 | |0;dojo.html;3223.790453620516;3251.845594813841;3273.328967561649;3278.393497203017;3284.573005509285;4914.262860570916;5110.671225481378;5507.228987941691;5537.0863807471715;5587.916181257285;5341.492558206974;5421.322334708161;5465.07093794055;5481.479259470354;5545.77816887325;3686.889393318205;4976.8506944791625;5043;5144.43411224765;5193.16909294513;466.5026704784701;4598.954010459903;4782.067496838118;4992;5052.141136006888;4530.546945305459;4629.749967508787;4662.417197850269;5087.135187018197;5091.46539613339;5068.113080210986;5095.974520127413;5117.283580298761;5119.769610367543;5149.30484384607;4942.752862356903;5024.296598476216;5038.420581633122;5102.566281866046;5153.2270159476375;4177.791110444496;5397.8380648580605;5427.43011983744;5457.126859702468;5523.2543606613;5951.077582974646;6019.247594050744;6026.457618814284;6042.154098426224;6048.969755151196;5842.5618078644275;5943.524518038546;6037.275526936795;6117.327094019654;6120.296165940929;5628.212050312959;5646.2942132233475;5669.092945128759;5702;5713.800016999427;6174.5060395168275;6190.50475961922;6191.4118158774845;6193.318734939153;6240.812775616739;5632.7746890123935;5708.372079071299;5886.91092147954;5952.375000624958;5961.940380596138;5952.851178720567;6003.369646187088;6007.579469437185;6042.4561789438285;6144.324124346318;5072.797088116434;5433.8369848904595;5936.584439089309;5940.70296485174;5958.285005799332;5786.247787787561;5865.090910908816;5894.970525147347;5910.143029260733;5964.761409543569;3760.3795373763023;4742.95257047432;4779.856604301876;4800.807967681323;4804.2073057945745;4039.2123535910214;4325.84859529915;4325.848595299212;4331.7184383015;4392.626626736763;5134.820281290212;5280.155175171954;5513.807016754475;5551.722413879371;5710.600257981901;6033.336333003366;6059.7273122709585;6084.239470066242;6126.731429653714;6139.43080903429;5719.370869204384;5725.77096916127;5728.083506638918;5739.454751798572;5753.252077229933;5078.187490001582;5274.498922602346;5274.973625131926;5279.736013199325;5280.551153152025;6082.847928801727;6096.9390306096375;6104.398524058527;6124.112003759519;6158.538109641884;6047.697615119138;6054.66699331541;6069.787557435468;6071.301800292847;6104.694765261808;6098.969505152446;6101.969490152521;6113.17472141273;6163.753449861955;6195.783147589813;5802.767889284381;5829.912551311819;5853.385394533683;5863.501602363847;5928.881422371443;6043.516518678583;6045.335013148462;6060.575759696779;6097.908531371944;6100.2984656763265;5656.745446454837;5837.620554663933;5841.269841269841;5859.648421094748;5861.296644402529;4804.279358096313;5614.578906581941;5779.826605201851;5806.158107074535;5809.883802323845;5585.525230355465;5589.357223919302;5710.486056254791;5736.4550367715;5749.108888122348;5701.458361455655;5838.4453476919625;5846.912296315473;5848.473637372657;5885.941140588539;4417.955820441883;4890.9021819562695;5134.9486505135965;5636.943630563642;5810.680412577349 10:21:20 INFO - PROCESS | 1670 | |1;ext.html;454.9044700612871;475.7549861821162;497.30874085021804;500.88479649680585;528.4055437632663;37311.81344093279;39001.80499097504;39017.219655606874;39150.80424597873;40554.59445405545;39747.80126099373;40183.799081004625;40271.19457610846;40314;40322.59677403225;9226.169644731974;9438.197753190987;9443.952780236124;9467.763305917339;9472.100150485727;9348.859767103499;9421.528923553795;9444.858327125065;9464.81070378592;9469.715908522721;9424.905750942471;9476.336656434018;9476.526173691287;9485.098915603006;9495.287853410988;9375.10936461035;9418.340716149873;9433.622655093788;9458.716238512856;9465.952670236606;9230.492322922237;9306.906930930672;9324.06759324069;9333.486658233795;9346.813063738755;38615.69762501048;38625.80687096546;38768.61231387678;38900;38904.805475972724;3219.307848812493;3299.307145499448;3319.3029463812386;3709.4992176056426;3921.607839216084;29384.8530757347;29638.851805740833;30000.69999300001;30487.932922347612;30578.38843223123;3144.308252184516;3150.9684903150905;3187.585613870205;3203.167176534095;3210.807351558914;363408;464706.6764666155;468851;469518;471305.7216567017;44511.33233001507;54557;54967.725161374736;55010;55204.447955520736;56170.438295617336;56579.15131273034;56735;56971.86056278934;57199.42800571941;14816.25918704082;15012.47456339023;15057.247137643293;15245.6188595286;15285.923570382078;11949.283043017447;12035.879641203652;12044.87955120455;12050.819237711441;12067.517299308105;12858.614241572768;13964.441422343196;14412.558744125503;14892.925535372255;14982.475613353481;5491.050677009684;6315.778947736807;6614.7023383947835;6650.501212409089;6652.8669426611195;807.382352500326;902.2466240688967;975.9902400976041;978.6085565773748;980.9705708828747;21396.57206855854;28251.43497130046;28396.006139785008;29203.7079629201;29275.7072429273;938.9483578403117;1019.9592016319264;1022.1822541966397;1031.9845202321972;1078.6116997880756;15503.767443488357;15754.527364179094;15871.28579213938;15990;16160.43438479671;642102;642888;648486;649320.5339732994;649709;45055.77472112684;48537.27194092092;52316.73841630767;52839.47160528423;52850.73574632102;1244.7074937389707;1329.9958531308994;1357.511295933463;1358.110437663332;1364.1814911053486;28464.715352847034;28622.427551448436;28691.569626456036;29141;29234;38964.610353896096;44094.559054409045;44806;45179.77410112928;45208.54791452044;585117;585838;586240.2751944852;587052;588311;23986.28041158768;24053.63919541173;24055.158069467485;24453.943257092862;24521.386965326008;41899.7905010473;42490;42561.574384257;42814.92962675958;42856.78571607122;34296.82851585726;35061.47407788834;35203.11992200215;36059.45910811392;36238.91283261401;35158.82420587881;35400;35803;36167.27665446729;36355.63644363522;34782.65217347896;34827;34880.30239395249;34973;35076.12309692278;30088.345141017453;30754.53868191934;32289;32298.677013229568;32314.676853231165;20497.795022049588;23881.761182387952;24019.759802401753;24513.77431128472;24526.509469810862 10:21:20 INFO - PROCESS | 1670 | |2;jquery.html;366.5088781033415;374.8978004666281;375.1016315923364;379.709522215505;395.1405692618554;18487.378155461134;18762.155702993365;19475.805241947575;19572.510687232825;19793.703094453595;18356.541086472844;18779.718304225447;18889.905550472264;19237.134328955195;19260.711089333636;5089.669171503859;5670;5934.88130237395;5937.67342796146;5939.67331796751;5662.6036177467595;6275.215598050244;6533.477321814267;6585;6592.6703664816805;6281.968590157066;6460.095586617877;6531.542792004561;6531.575447595915;6551;6244.781432649836;6462.386073323027;6489.156409666761;6511.4465270452065;6524.086627872101;5546.805861794818;5595.63628364155;5602.24369710088;5625.128105143709;5625.296837895263;21082.578348432944;21087.578248434944;22008.559828803332;24343.513129737483;24401.755982440125;2114.4819519217735;2116.11123328201;2164.8701077935375;2317.478567322356;2375.239923224569;14449.855501444956;14818.555443336718;14896.702065958729;15079.924600377037;15453.613659658486;1780.6972814621545;1830.3438707759417;1866.6453373858924;1879.1919474625906;1897.9810201897942;98533.53666158332;109194.3620845688;115594.84405155925;119953.20070198954;119979.40010299893;9468.763280917894;10220.233482488844;10257.743556411;10501.264911456125;10506.159507239403;13359.26524041187;13396.933015335057;13424.664383390493;13454;13686.52097176594;6770.763023294161;7010.369066784014;7887.684492620346;7902.209779022167;8297.95851020741;8088.514689118671;8138.064122625856;8258.339332853357;8268.2558569729;8468.44955077918;4895.730734809548;5405.324334458192;5631.493165615032;6447.065175549519;6456.51576131792;1616.1434439746954;1646.8517833395051;1664.7003539363031;1828.5794267318324;1843.0416183584462;765.1330752962753;902.4495058014605;951.9143277105094;979.0405402705388;995.0149352141328;16087.678246435005;17130.48608541746;21022.78977210208;21416.78583214179;21690;884.7743825324501;893.8972018217858;941.6186444489992;958.5111593087576;975.4488713876636;10635.52140153695;11149.386783726974;11265.436728163559;11275.210735248455;11341.603043893425;576388;577402;579665;592732;594497;116634.8336516641;117398.41300793442;119103;119136;122326;971.2327261463506;990.2177279948904;1023.5598692562121;1029.1920842138884;1032.0453580438066;13331.933340333237;17240.396586119427;18507;18626.906865465586;19051.523711907314;49095;49408.75295623499;49857.50142498528;51078;51594.96810063702;70413.64793176002;71943.28056719575;73767.63116184385;74129;82115.17884821075;7341.265873412616;7405.2224516425;7409.703611855465;7609.733659321897;7799.844003120019;9350.81298374015;11075.612353567587;11657.125715571197;11762.705932351417;12134.817977730518;10026.849597256192;10089.495525223563;10107;10198.031187037219;10323.070923616911;9758.46328451942;9951.900480995097;10060.446675432922;10260.948695256477;10273.84589231177;8733.475991440533;8988.370814042953;10021.549030293509;10312.587496500057;10360.015798499131;7137.607431591105;7439.032925719838;7600.80997975055;7632.732854350071;7747.418943579141;7630.618469076635;8912.86630700527;9479.431234125974;9863.802723945624;10266.435346056038 10:21:20 INFO - PROCESS | 1670 | |3;mootools.html;1285.7621340052092;1418.43262694922;1453.462218978978;1715.7254839225718;1769.6283780406113;7624.35193008595;7822.843543129134;8051.91948080519;8525.701600443987;8557.828843423127;7280.8179795505;7559.979402780623;8289.046759622644;8402.411831171821;8415.579221038954;2301.2866011536435;2330.4639932815376;2331.25399872041;2335.1243283768586;2339.2046704120594;1987.5826076523947;2326.360250930999;2358.2099996501192;2358.9410264743433;2374.3470545599926;2296.689946857178;2306.2965795432387;2324.2910912171783;2343.61330380487;2347.6595893595418;2265.76209498002;2271.3867255840914;2295.426143464142;2297.8276629252873;2303.2169062518656;2286.2455389721354;2352.752960939111;2354.5761762882676;2355.658429527726;2357.10430036585;8393.454425462325;8458.323334133254;8459.57702114898;8468.407211495198;8477.10990346011;5099.566536844372;5256.448072952323;5262.210668399733;5269.657472264291;5274.472552744734;3291.703746662788;3459.9481007784902;3546.858125674996;3633.4731463937846;3650.324689932371;1020.5713600287897;1049.422817450407;1077.385890042676;1081.1242893256488;1096.0464395975473;10950.780984380348;10963.50664220104;11062.834057489144;11105.55577776888;11214.775704485946;4470.97167651442;4627.583517483443;4703.717776933327;4765.785539650724;4780.5697487225625;9480.241580673668;9492.857607135898;9512.28657850664;9513.857292140623;9522.238220942309;5232.3982741985155;5236.869078273074;5239.030779305841;5250.684958902478;5256.316678831728;4305.5048669402795;4316.460442444694;4753.809847606126;4790.784414701347;4806.158922188603;3109.518024706174;3801.125741079567;3842.289176502356;3877.592852750477;3903.902402439905;1258.2764910176502;1270.8602053774077;1280.5390059578544;1282.5318758653025;1287.2855565161426;836.9455985360933;865.3250464637592;866.8526350520426;870.851955167623;880.6257340630207;5610.214569960209;5642.351129620064;5739.827805165852;5789.565782566325;6051.636901785907;910.7040211931148;913.1142791492242;929.6932012436015;946.6497395963538;976.82417164911;3259;3634.236810269873;3659.70722342212;3933.7639741615594;3942.6254505821903;7805.141434442206;8057.879131813028;9085.863712044193;9517.524123793783;9906.7027989159;8410.36922230835;10120.342177758423;10218.540165692562;10221.284510084222;10223.591056357662;7709.5374277542405;7791.376689864797;7854.450188486865;7875.803104922423;7930.5638189898955;5618.775248989995;5719.170720245625;5819.156222347651;5910.674912879833;5921.851953701192;9427.9258563116;9499.57251923679;9546.952265238908;9576.712698619052;9584.472853993097;9103.635854565744;9498.905010949802;9526.095020972996;9572.856407154037;9632.373895696757;5455.699936503372;6657.40083392497;6866.793996179923;6867.175938887365;7353.852922941618;7283.890741638774;7980.361571074416;8028.277455029075;8075.959620202097;8081.272685458337;7108.537945033556;7230.566166029845;7248.855022899618;7326.780196594111;7366.594837284001;7004.859902802017;7096.077509923677;7129.679164437716;7202.207757146605;7219.819504512219;5624.57815663835;6608.966955165193;6735.292794256533;6736.865262694817;6738.191417029988;4800.783964721526;4859.489753575824;4860.1251774680895;4878.463369029475;4966.652334336562;4440.444944381952;4709.599684026896;4813.15769740301;4868.050730107595;4878.243872199815 10:21:20 INFO - PROCESS | 1670 | |4;prototype.html;301.4769375134142;304.18781852453947;311.6571771051843;315.6275594798137;317.8013741411618;5114.360704911886;5243.344581927249;5384.6769193848395;5518.779248830047;5531.225628412026;4524.868782804299;5234.848333366663;5370.462953704638;5388.595855310858;5438.7280635968245;4139.275626765311;4150.045489537408;4169.312063509517;4187.33002719565;4192.107445862345;3786.318462676717;4083.3666533386586;4157.916841663165;4174.394712766647;4194.909323575862;3638.745287829853;4047.793952295991;4079.3897400800356;4088.0393107619684;4114.362273847559;3623.9852841204242;4051.9797401012806;4068.7558746475156;4089.9591004089875;4110.362893751443;2956.2609347663083;3385.9334309692613;3551.5560554930635;3551.627079156677;3584.4981702561663;4939.518144556655;5016.49835016499;5293.682379057269;5310.601704872111;5357.598180136466;3807.3908174691915;4116.526599441043;4356.738595684237;4626.768661566942;4671.299305104228;4736.129228954544;5082.99221807384;5406.810761623325;5488.890222195574;5673.035583950697;3495.94756078659;3663.5454245655474;3726.496922915399;3817.6373244541724;3897.337452633059;4762.738049407281;5150.819721309736;5709.600327977043;5958.255218097738;6020.4280593343565;3365.8148801815646;3469.2541103662834;3506.8071256080652;3831.3103641344824;3937.409388591677;3845.769253844778;3899.6100389961343;3959.465472161279;3983.1635356574866;4010.1578668479365;4464.464264288306;4581.5647513486165;4624.237000894882;4634.467036290802;4652.55800698933;4874.195757699939;5336.973315133399;5748.770049198069;5766;5794.768209271582;1142.628645690154;1172.355204637463;1198.0116403966763;1261.7161138743709;1268.5243033862303;757.9848403031908;766.2835249042164;822.0915887943855;845.471580262336;846.5439444156042;4520.4575450946095;4999.850004499871;5032.874178145576;5048.242763585492;5133.25567792668;5542.224088627595;5563.610547261653;5590.105583106765;5627.606067575231;5632.592281669613;4329.307310830252;4392.407025051641;4670.906581868411;4694.647901407408;5029.748512574357;2529.3676580854785;2569.7430256974526;2724.9591256131175;2915.4169166166853;2951.276937150412;5109.923351149736;5412.3505179377935;5549.916751248735;5745.6552606843725;5790;4474.6420286377015;4704.482506924235;4926.472793434047;5622.156676498476;6092.878142437126;5218.478152184751;6062.666553339521;6177.752889884444;6198.776636149268;6252.906206406908;4719.451496192018;5005.649604527648;5724.942750572441;5804.593678442468;5944.73248703818;4953.702777833341;5687.60186786921;5793;5832.625530851861;5911.231539899785;4952.504749525018;5938.7231745174995;6131.693415329127;6139.605553834098;6152;3579.6599323064265;3641.1807343347537;3979.621935916083;3981.5222173339384;4008.158286759813;5524.309461317335;5849.736761845642;5928.970355148197;5976.282846058501;6008.819735407945;4884.535969082932;5542.418046105101;5657.519110875622;5818.214541036906;5822.330432000204;5390.975714614211;5517.875617887062;5535;5765.538756899354;5814.447627475383;4699.553542413465;5135.820246291362;5345;5701.489105386992;5713.285839270091;4646.629244372985;5217.582593392595;5468.4531546845;5780.566457515619;5806.709664516673;5644;5671.801486947937;5699.945510080648;5736.942630573808;5765.740541675718 10:21:20 INFO - PROCESS | 1670 | |5;yui.html;587.6650309323685;674.8380388706711;675.689182975831;691.1153723234258;691.7721045144867;12179.269243845376;13884.23636699981;14667.48663796766;14797.112173269585;14818.703625927476;13011.349432528383;13231.536896208634;13261.27063011534;13457;13468.191908485473;823.300194834389;836.113719457374;840.6553313141613;841.1210285251896;843.8692002739585;671.7145213284359;678.3894494954556;687.2508965227901;849.2908421468081;862.8490014247482;735.4447392218867;884.4693184089527;885.5926273914007;885.8006948436615;891.8260939116875;729.7263526177684;881.7927786970057;884.3234925282164;884.995575022124;887.968921087762;664.1498881431775;666.9695320729436;667.2493444874516;668.3951024322995;669.6919417068154;13375;13768.311584420739;13843.100198487065;13858.514951976633;13867.4453021879;11160.720981975435;12958.546450874173;13310.733785324335;13366.198028118344;13452.1256118352;11294.717632059183;11380.317180969085;11382.203245772716;11394.430278486125;11631.88368116325;3603.225306559076;3610.097475631092;3613.5302410686704;3619.5294611700574;3626.5829429615405;89653.55173224157;91025.7243568916;92108;92915.07084929131;92992.53503732574;10142.391456512632;10150.238732095122;10189.388636681822;10205.846912296322;10581.89418105809;20016.399508014783;20121.39635810928;20124.396268111686;20345.62569047662;20398.388048358574;7252.601106939063;7291.34377905991;7372.336489715952;7396.3713084387355;7505.812354691177;3793.867214647474;4086.0602061526015;4181.811818468176;4245.936310955338;4288.24955632763;3272.672732726708;3356.8992930212135;3378.3074469733647;3384.7630665853644;3397.490376443553;541.908055268634;609.2082267794855;618.9597676151036;623.2956758862456;629.5750368501243;497.00102793385554;552.5463673542085;606.9696515174223;641.9967900160469;656.1601150527238;6981.5112942093565;7606.277403646644;7742.61286935651;8731.519766412908;8820.250278726251;592.925884264467;636.48762745989;641.5605310362416;669.8727241824038;706.4701473894579;4086.182763447263;4147.502299724052;4225.239456897788;4341.413909122291;4407;113475;114077.42961285307;122578.16132758016;124353;124941;106112;107993.46003270091;109447;110564;112517;95176;96373.9999999986;97577.51211243898;98308;98729;8269.80087887265;8278.83442331138;8293.92179016748;8327;8499.660013599387;55590.72204638951;58900;60009.69995149996;60217.39782602118;61511;45514.54485455103;52970;62854.68572657107;69454;72443.55112897819;11495.942520287344;11782.293062416282;11881.346525940811;11977.820332695192;12205.938970305091;12608.87391126077;13162;13208.801867971795;13269.800952985906;14113.364898579382;10930.562777489129;11451.198416110792;12121.575744848888;12132.757344852876;12661.74676506483;11943.522259109886;11981.28112313264;12059.336736479227;12069.456874440495;12484.563040293546;11147.777044459228;11876.346800925687;12035.037197024392;12121.212121212093;12491.812622810847;8437;9373.11858452883;10076.89923100789;10473.528691209067;10486.947565262124;10339.121174700234;10590.947045264724;10640.787184256425;10642.521086550969;10654.8401773975 10:21:20 INFO - PROCESS | 1670 | __end_tp_report 10:21:20 INFO - PROCESS | 1670 | __start_cc_report 10:21:20 INFO - PROCESS | 1670 | _x_x_mozilla_cycle_collect,365 10:21:20 INFO - PROCESS | 1670 | __end_cc_report 10:21:20 INFO - PROCESS | 1670 | __startTimestamp1478366480553__endTimestamp 10:21:20 INFO - PROCESS | 1670 | 10:21:20 INFO - PROCESS | 1670 | ------- Summary: start ------- 10:21:20 INFO - PROCESS | 1670 | Number of tests: 6 10:21:20 INFO - PROCESS | 1670 | 10:21:20 INFO - PROCESS | 1670 | [#0] dojo.html Cycles:165 Average:5453.17 Median:5710.49 stddev:774.21 (13.6%) stddev-sans-first:756.57 10:21:20 INFO - PROCESS | 1670 | Values: 3223.8 3251.8 3273.3 3278.4 3284.6 4914.3 5110.7 5507.2 5537.1 5587.9 5341.5 5421.3 5465.1 5481.5 5545.8 3686.9 4976.9 5043.0 5144.4 5193.2 466.5 4599.0 4782.1 4992.0 5052.1 4530.5 4629.7 4662.4 5087.1 5091.5 5068.1 5096.0 5117.3 5119.8 5149.3 4942.8 5024.3 5038.4 5102.6 5153.2 4177.8 5397.8 5427.4 5457.1 5523.3 5951.1 6019.2 6026.5 6042.2 6049.0 5842.6 5943.5 6037.3 6117.3 6120.3 5628.2 5646.3 5669.1 5702.0 5713.8 6174.5 6190.5 6191.4 6193.3 6240.8 5632.8 5708.4 5886.9 5952.4 5961.9 5952.9 6003.4 6007.6 6042.5 6144.3 5072.8 5433.8 5936.6 5940.7 5958.3 5786.2 5865.1 5895.0 5910.1 5964.8 3760.4 4743.0 4779.9 4800.8 4804.2 4039.2 4325.8 4325.8 4331.7 4392.6 5134.8 5280.2 5513.8 5551.7 5710.6 6033.3 6059.7 6084.2 6126.7 6139.4 5719.4 5725.8 5728.1 5739.5 5753.3 5078.2 5274.5 5275.0 5279.7 5280.6 6082.8 6096.9 6104.4 6124.1 6158.5 6047.7 6054.7 6069.8 6071.3 6104.7 6099.0 6102.0 6113.2 6163.8 6195.8 5802.8 5829.9 5853.4 5863.5 5928.9 6043.5 6045.3 6060.6 6097.9 6100.3 5656.7 5837.6 5841.3 5859.6 5861.3 4804.3 5614.6 5779.8 5806.2 5809.9 5585.5 5589.4 5710.5 5736.5 5749.1 5701.5 5838.4 5846.9 5848.5 5885.9 4418.0 4890.9 5134.9 5636.9 5810.7 10:21:20 INFO - PROCESS | 1670 | 10:21:20 INFO - PROCESS | 1670 | [#1] ext.html Cycles:180 Average:67696.55 Median:38983.21 stddev:151870.30 (389.6%) stddev-sans-first:152212.42 10:21:20 INFO - PROCESS | 1670 | Values: 454.9 475.8 497.3 500.9 528.4 37311.8 39001.8 39017.2 39150.8 40554.6 39747.8 40183.8 40271.2 40314.0 40322.6 9226.2 9438.2 9444.0 9467.8 9472.1 9348.9 9421.5 9444.9 9464.8 9469.7 9424.9 9476.3 9476.5 9485.1 9495.3 9375.1 9418.3 9433.6 9458.7 9466.0 9230.5 9306.9 9324.1 9333.5 9346.8 38615.7 38625.8 38768.6 38900.0 38904.8 3219.3 3299.3 3319.3 3709.5 3921.6 29384.9 29638.9 30000.7 30487.9 30578.4 3144.3 3151.0 3187.6 3203.2 3210.8 363408.0 464706.7 468851.0 469518.0 471305.7 44511.3 54557.0 54967.7 55010.0 55204.4 56170.4 56579.2 56735.0 56971.9 57199.4 14816.3 15012.5 15057.2 15245.6 15285.9 11949.3 12035.9 12044.9 12050.8 12067.5 12858.6 13964.4 14412.6 14892.9 14982.5 5491.1 6315.8 6614.7 6650.5 6652.9 807.4 902.2 976.0 978.6 981.0 21396.6 28251.4 28396.0 29203.7 29275.7 938.9 1020.0 1022.2 1032.0 1078.6 15503.8 15754.5 15871.3 15990.0 16160.4 642102.0 642888.0 648486.0 649320.5 649709.0 45055.8 48537.3 52316.7 52839.5 52850.7 1244.7 1330.0 1357.5 1358.1 1364.2 28464.7 28622.4 28691.6 29141.0 29234.0 38964.6 44094.6 44806.0 45179.8 45208.5 585117.0 585838.0 586240.3 587052.0 588311.0 23986.3 24053.6 24055.2 24453.9 24521.4 41899.8 42490.0 42561.6 42814.9 42856.8 34296.8 35061.5 35203.1 36059.5 36238.9 35158.8 35400.0 35803.0 36167.3 36355.6 34782.7 34827.0 34880.3 34973.0 35076.1 30088.3 30754.5 32289.0 32298.7 32314.7 20497.8 23881.8 24019.8 24513.8 24526.5 10:21:20 INFO - PROCESS | 1670 | 10:21:20 INFO - PROCESS | 1670 | [#2] jquery.html Cycles:180 Average:33726.72 Median:387.43 stddev:97290.17 (25112.0%) stddev-sans-first:97530.84 10:21:20 INFO - PROCESS | 1670 | Values: 366.5 374.9 375.1 379.7 395.1 18487.4 18762.2 19475.8 19572.5 19793.7 18356.5 18779.7 18889.9 19237.1 19260.7 5089.7 5670.0 5934.9 5937.7 5939.7 5662.6 6275.2 6533.5 6585.0 6592.7 6282.0 6460.1 6531.5 6531.6 6551.0 6244.8 6462.4 6489.2 6511.4 6524.1 5546.8 5595.6 5602.2 5625.1 5625.3 21082.6 21087.6 22008.6 24343.5 24401.8 2114.5 2116.1 2164.9 2317.5 2375.2 14449.9 14818.6 14896.7 15079.9 15453.6 1780.7 1830.3 1866.6 1879.2 1898.0 98533.5 109194.4 115594.8 119953.2 119979.4 9468.8 10220.2 10257.7 10501.3 10506.2 13359.3 13396.9 13424.7 13454.0 13686.5 6770.8 7010.4 7887.7 7902.2 8298.0 8088.5 8138.1 8258.3 8268.3 8468.4 4895.7 5405.3 5631.5 6447.1 6456.5 1616.1 1646.9 1664.7 1828.6 1843.0 765.1 902.4 951.9 979.0 995.0 16087.7 17130.5 21022.8 21416.8 21690.0 884.8 893.9 941.6 958.5 975.4 10635.5 11149.4 11265.4 11275.2 11341.6 576388.0 577402.0 579665.0 592732.0 594497.0 116634.8 117398.4 119103.0 119136.0 122326.0 971.2 990.2 1023.6 1029.2 1032.0 13331.9 17240.4 18507.0 18626.9 19051.5 49095.0 49408.8 49857.5 51078.0 51595.0 70413.6 71943.3 73767.6 74129.0 82115.2 7341.3 7405.2 7409.7 7609.7 7799.8 9350.8 11075.6 11657.1 11762.7 12134.8 10026.8 10089.5 10107.0 10198.0 10323.1 9758.5 9951.9 10060.4 10260.9 10273.8 8733.5 8988.4 10021.5 10312.6 10360.0 7137.6 7439.0 7600.8 7632.7 7747.4 7630.6 8912.9 9479.4 9863.8 10266.4 10:21:20 INFO - PROCESS | 1670 | 10:21:20 INFO - PROCESS | 1670 | [#3] mootools.html Cycles:180 Average:5420.13 Median:5259.33 stddev:2952.68 (56.1%) stddev-sans-first:2944.61 10:21:20 INFO - PROCESS | 1670 | Values: 1285.8 1418.4 1453.5 1715.7 1769.6 7624.4 7822.8 8051.9 8525.7 8557.8 7280.8 7560.0 8289.0 8402.4 8415.6 2301.3 2330.5 2331.3 2335.1 2339.2 1987.6 2326.4 2358.2 2358.9 2374.3 2296.7 2306.3 2324.3 2343.6 2347.7 2265.8 2271.4 2295.4 2297.8 2303.2 2286.2 2352.8 2354.6 2355.7 2357.1 8393.5 8458.3 8459.6 8468.4 8477.1 5099.6 5256.4 5262.2 5269.7 5274.5 3291.7 3459.9 3546.9 3633.5 3650.3 1020.6 1049.4 1077.4 1081.1 1096.0 10950.8 10963.5 11062.8 11105.6 11214.8 4471.0 4627.6 4703.7 4765.8 4780.6 9480.2 9492.9 9512.3 9513.9 9522.2 5232.4 5236.9 5239.0 5250.7 5256.3 4305.5 4316.5 4753.8 4790.8 4806.2 3109.5 3801.1 3842.3 3877.6 3903.9 1258.3 1270.9 1280.5 1282.5 1287.3 836.9 865.3 866.9 870.9 880.6 5610.2 5642.4 5739.8 5789.6 6051.6 910.7 913.1 929.7 946.6 976.8 3259.0 3634.2 3659.7 3933.8 3942.6 7805.1 8057.9 9085.9 9517.5 9906.7 8410.4 10120.3 10218.5 10221.3 10223.6 7709.5 7791.4 7854.5 7875.8 7930.6 5618.8 5719.2 5819.2 5910.7 5921.9 9427.9 9499.6 9547.0 9576.7 9584.5 9103.6 9498.9 9526.1 9572.9 9632.4 5455.7 6657.4 6866.8 6867.2 7353.9 7283.9 7980.4 8028.3 8076.0 8081.3 7108.5 7230.6 7248.9 7326.8 7366.6 7004.9 7096.1 7129.7 7202.2 7219.8 5624.6 6609.0 6735.3 6736.9 6738.2 4800.8 4859.5 4860.1 4878.5 4966.7 4440.4 4709.6 4813.2 4868.1 4878.2 10:21:20 INFO - PROCESS | 1670 | 10:21:20 INFO - PROCESS | 1670 | [#4] prototype.html Cycles:180 Average:4526.25 Median:5011.07 stddev:1423.92 (28.4%) stddev-sans-first:1392.15 10:21:20 INFO - PROCESS | 1670 | Values: 301.5 304.2 311.7 315.6 317.8 5114.4 5243.3 5384.7 5518.8 5531.2 4524.9 5234.8 5370.5 5388.6 5438.7 4139.3 4150.0 4169.3 4187.3 4192.1 3786.3 4083.4 4157.9 4174.4 4194.9 3638.7 4047.8 4079.4 4088.0 4114.4 3624.0 4052.0 4068.8 4090.0 4110.4 2956.3 3385.9 3551.6 3551.6 3584.5 4939.5 5016.5 5293.7 5310.6 5357.6 3807.4 4116.5 4356.7 4626.8 4671.3 4736.1 5083.0 5406.8 5488.9 5673.0 3495.9 3663.5 3726.5 3817.6 3897.3 4762.7 5150.8 5709.6 5958.3 6020.4 3365.8 3469.3 3506.8 3831.3 3937.4 3845.8 3899.6 3959.5 3983.2 4010.2 4464.5 4581.6 4624.2 4634.5 4652.6 4874.2 5337.0 5748.8 5766.0 5794.8 1142.6 1172.4 1198.0 1261.7 1268.5 758.0 766.3 822.1 845.5 846.5 4520.5 4999.9 5032.9 5048.2 5133.3 5542.2 5563.6 5590.1 5627.6 5632.6 4329.3 4392.4 4670.9 4694.6 5029.7 2529.4 2569.7 2725.0 2915.4 2951.3 5109.9 5412.4 5549.9 5745.7 5790.0 4474.6 4704.5 4926.5 5622.2 6092.9 5218.5 6062.7 6177.8 6198.8 6252.9 4719.5 5005.6 5724.9 5804.6 5944.7 4953.7 5687.6 5793.0 5832.6 5911.2 4952.5 5938.7 6131.7 6139.6 6152.0 3579.7 3641.2 3979.6 3981.5 4008.2 5524.3 5849.7 5929.0 5976.3 6008.8 4884.5 5542.4 5657.5 5818.2 5822.3 5391.0 5517.9 5535.0 5765.5 5814.4 4699.6 5135.8 5345.0 5701.5 5713.3 4646.6 5217.6 5468.5 5780.6 5806.7 5644.0 5671.8 5699.9 5736.9 5765.7 10:21:20 INFO - PROCESS | 1670 | 10:21:20 INFO - PROCESS | 1670 | [#5] yui.html Cycles:180 Average:21132.30 Median:4116.84 stddev:32591.62 (791.7%) stddev-sans-first:32646.54 10:21:20 INFO - PROCESS | 1670 | Values: 587.7 674.8 675.7 691.1 691.8 12179.3 13884.2 14667.5 14797.1 14818.7 13011.3 13231.5 13261.3 13457.0 13468.2 823.3 836.1 840.7 841.1 843.9 671.7 678.4 687.3 849.3 862.8 735.4 884.5 885.6 885.8 891.8 729.7 881.8 884.3 885.0 888.0 664.1 667.0 667.2 668.4 669.7 13375.0 13768.3 13843.1 13858.5 13867.4 11160.7 12958.5 13310.7 13366.2 13452.1 11294.7 11380.3 11382.2 11394.4 11631.9 3603.2 3610.1 3613.5 3619.5 3626.6 89653.6 91025.7 92108.0 92915.1 92992.5 10142.4 10150.2 10189.4 10205.8 10581.9 20016.4 20121.4 20124.4 20345.6 20398.4 7252.6 7291.3 7372.3 7396.4 7505.8 3793.9 4086.1 4181.8 4245.9 4288.2 3272.7 3356.9 3378.3 3384.8 3397.5 541.9 609.2 619.0 623.3 629.6 497.0 552.5 607.0 642.0 656.2 6981.5 7606.3 7742.6 8731.5 8820.3 592.9 636.5 641.6 669.9 706.5 4086.2 4147.5 4225.2 4341.4 4407.0 113475.0 114077.4 122578.2 124353.0 124941.0 106112.0 107993.5 109447.0 110564.0 112517.0 95176.0 96374.0 97577.5 98308.0 98729.0 8269.8 8278.8 8293.9 8327.0 8499.7 55590.7 58900.0 60009.7 60217.4 61511.0 45514.5 52970.0 62854.7 69454.0 72443.6 11495.9 11782.3 11881.3 11977.8 12205.9 12608.9 13162.0 13208.8 13269.8 14113.4 10930.6 11451.2 12121.6 12132.8 12661.7 11943.5 11981.3 12059.3 12069.5 12484.6 11147.8 11876.3 12035.0 12121.2 12491.8 8437.0 9373.1 10076.9 10473.5 10486.9 10339.1 10590.9 10640.8 10642.5 10654.8 10:21:20 INFO - PROCESS | 1670 | -------- Summary: end -------- 10:21:20 INFO - PROCESS | 1670 | 10:21:21 INFO - TEST-INFO | 1670: exit 0 10:21:21 INFO - TEST-OK | dromaeo_css | took 1114362ms 10:21:21 INFO - TEST-START | kraken 10:21:21 INFO - operating with platform_type : mac_ 10:21:21 INFO - Initialising browser for kraken test... 10:21:21 INFO - TEST-INFO | started process 1677 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/tmp34L19Q/profile http://localhost:49274/getInfo.html) 10:21:23 INFO - PROCESS | 1677 | 2016-11-05 10:21:23.687 plugin-container[1678:11968] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4447, name = 'com.apple.tsm.portname' 10:21:23 INFO - PROCESS | 1677 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:21:23 INFO - PROCESS | 1677 | 2016-11-05 10:21:23.690 plugin-container[1678:11968] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0b, name = 'com.apple.CFPasteboardClient' 10:21:23 INFO - PROCESS | 1677 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:21:23 INFO - PROCESS | 1677 | 2016-11-05 10:21:23.690 plugin-container[1678:11968] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:21:23 INFO - PROCESS | 1677 | __metrics Screen width/height:1600/1200 10:21:23 INFO - PROCESS | 1677 | colorDepth:24 10:21:23 INFO - PROCESS | 1677 | Browser inner width/height: 1024/689 10:21:23 INFO - PROCESS | 1677 | __metrics 10:21:23 ERROR - PROCESS | 1677 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3158: TypeError: this.tabs is undefined 10:21:24 INFO - TEST-INFO | 1677: exit 0 10:21:24 INFO - Browser initialized. 10:21:24 INFO - Running cycle 1/1 for kraken test... 10:21:24 INFO - TEST-INFO | started process 1679 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/tmp34L19Q/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:21:26 INFO - PROCESS | 1679 | 2016-11-05 10:21:26.871 plugin-container[1680:12082] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x863f, name = 'com.apple.tsm.portname' 10:21:26 INFO - PROCESS | 1679 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:21:26 INFO - PROCESS | 1679 | 2016-11-05 10:21:26.872 plugin-container[1680:12082] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8953, name = 'com.apple.CFPasteboardClient' 10:21:26 INFO - PROCESS | 1679 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:21:26 INFO - PROCESS | 1679 | 2016-11-05 10:21:26.872 plugin-container[1680:12082] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:21:36 INFO - PROCESS | 1679 | RSS: Main: 238596096 10:21:36 INFO - PROCESS | 1679 | 10:21:39 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection) 10:21:40 INFO - PROCESS | 1679 | RSS: Main: 251015168 10:21:40 INFO - PROCESS | 1679 | 10:21:43 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-dft) 10:21:43 INFO - PROCESS | 1679 | RSS: Main: 258600960 10:21:43 INFO - PROCESS | 1679 | 10:21:47 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-fft) 10:21:47 INFO - PROCESS | 1679 | RSS: Main: 261324800 10:21:47 INFO - PROCESS | 1679 | 10:21:49 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator) 10:21:50 INFO - PROCESS | 1679 | RSS: Main: 262352896 10:21:50 INFO - PROCESS | 1679 | 10:21:52 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:21:53 INFO - PROCESS | 1679 | RSS: Main: 264028160 10:21:53 INFO - PROCESS | 1679 | 10:21:55 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom) 10:21:56 INFO - PROCESS | 1679 | RSS: Main: 264159232 10:21:56 INFO - PROCESS | 1679 | 10:21:59 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate) 10:22:00 INFO - PROCESS | 1679 | RSS: Main: 264306688 10:22:00 INFO - PROCESS | 1679 | 10:22:03 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial) 10:22:03 INFO - PROCESS | 1679 | RSS: Main: 264757248 10:22:03 INFO - PROCESS | 1679 | 10:22:05 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:22:05 INFO - PROCESS | 1679 | RSS: Main: 264245248 10:22:05 INFO - PROCESS | 1679 | 10:22:07 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:22:08 INFO - PROCESS | 1679 | RSS: Main: 264433664 10:22:08 INFO - PROCESS | 1679 | 10:22:10 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:22:11 INFO - PROCESS | 1679 | RSS: Main: 264355840 10:22:11 INFO - PROCESS | 1679 | 10:22:14 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:22:15 INFO - PROCESS | 1679 | RSS: Main: 264884224 10:22:15 INFO - PROCESS | 1679 | 10:22:18 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:22:19 INFO - PROCESS | 1679 | RSS: Main: 264957952 10:22:19 INFO - PROCESS | 1679 | 10:22:21 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49274/tests/kraken/driver.html?testName=ai-astar) 10:22:21 INFO - PROCESS | 1679 | RSS: Main: 266596352 10:22:21 INFO - PROCESS | 1679 | 10:22:21 INFO - PROCESS | 1679 | __start_tp_report 10:22:21 INFO - PROCESS | 1679 | _x_x_mozilla_page_load 10:22:21 INFO - PROCESS | 1679 | _x_x_mozilla_page_load_details 10:22:21 INFO - PROCESS | 1679 | |i|pagename|runs| 10:22:21 INFO - PROCESS | 1679 | |0;ai-astar;106;117;118;116;115;116;117;117;116;117 10:22:21 INFO - PROCESS | 1679 | |1;audio-beat-detection;140;121;104;186;121;113;119;118;144;116 10:22:21 INFO - PROCESS | 1679 | |2;audio-dft;201;199;206;259;193;270;275;195;193;196 10:22:21 INFO - PROCESS | 1679 | |3;audio-fft;83;61;79;74;76;85;85;84;94;61 10:22:21 INFO - PROCESS | 1679 | |4;audio-oscillator;85;71;87;71;55;79;123;57;94;74 10:22:21 INFO - PROCESS | 1679 | |5;imaging-gaussian-blur;89;87;88;107;82;132;138;114;90;86 10:22:21 INFO - PROCESS | 1679 | |6;imaging-darkroom;142;95;106;131;95;107;125;95;96;96 10:22:21 INFO - PROCESS | 1679 | |7;imaging-desaturate;87;91;90;133;142;114;91;89;89;90 10:22:21 INFO - PROCESS | 1679 | |8;json-parse-financial;55;56;56;56;57;72;57;57;55;58 10:22:21 INFO - PROCESS | 1679 | |9;json-stringify-tinderbox;68;76;66;114;67;77;96;64;78;107 10:22:21 INFO - PROCESS | 1679 | |10;stanford-crypto-aes;92;87;87;100;80;89;81;115;112;111 10:22:21 INFO - PROCESS | 1679 | |11;stanford-crypto-ccm;153;146;150;166;162;161;168;172;196;161 10:22:21 INFO - PROCESS | 1679 | |12;stanford-crypto-pbkdf2;179;164;233;252;205;178;174;213;238;194 10:22:21 INFO - PROCESS | 1679 | |13;stanford-crypto-sha256-iterative;66;70;85;100;91;95;78;67;70;67 10:22:21 INFO - PROCESS | 1679 | __end_tp_report 10:22:21 INFO - PROCESS | 1679 | __start_cc_report 10:22:21 INFO - PROCESS | 1679 | _x_x_mozilla_cycle_collect,959 10:22:21 INFO - PROCESS | 1679 | __end_cc_report 10:22:21 INFO - PROCESS | 1679 | __startTimestamp1478366541293__endTimestamp 10:22:21 INFO - PROCESS | 1679 | 10:22:21 INFO - PROCESS | 1679 | ------- Summary: start ------- 10:22:21 INFO - PROCESS | 1679 | Number of tests: 14 10:22:21 INFO - PROCESS | 1679 | 10:22:21 INFO - PROCESS | 1679 | [#0] ai-astar Cycles:10 Average:115.50 Median:117.00 stddev:3.44 (2.9%) stddev-sans-first:0.88 10:22:21 INFO - PROCESS | 1679 | Values: 106.0 117.0 118.0 116.0 115.0 116.0 117.0 117.0 116.0 117.0 10:22:21 INFO - PROCESS | 1679 | 10:22:21 INFO - PROCESS | 1679 | [#1] audio-beat-detection Cycles:10 Average:128.20 Median:121.00 stddev:23.54 (19.5%) stddev-sans-first:24.58 10:22:21 INFO - PROCESS | 1679 | Values: 140.0 121.0 104.0 186.0 121.0 113.0 119.0 118.0 144.0 116.0 10:22:21 INFO - PROCESS | 1679 | 10:22:21 INFO - PROCESS | 1679 | [#2] audio-dft Cycles:10 Average:218.70 Median:203.50 stddev:34.46 (16.9%) stddev-sans-first:35.95 10:22:21 INFO - PROCESS | 1679 | Values: 201.0 199.0 206.0 259.0 193.0 270.0 275.0 195.0 193.0 196.0 10:22:21 INFO - PROCESS | 1679 | 10:22:21 INFO - PROCESS | 1679 | [#3] audio-fft Cycles:10 Average:78.20 Median:83.50 stddev:10.61 (12.7%) stddev-sans-first:11.11 10:22:21 INFO - PROCESS | 1679 | Values: 83.0 61.0 79.0 74.0 76.0 85.0 85.0 84.0 94.0 61.0 10:22:21 INFO - PROCESS | 1679 | 10:22:21 INFO - PROCESS | 1679 | [#4] audio-oscillator Cycles:10 Average:79.60 Median:76.50 stddev:19.64 (25.7%) stddev-sans-first:20.73 10:22:21 INFO - PROCESS | 1679 | Values: 85.0 71.0 87.0 71.0 55.0 79.0 123.0 57.0 94.0 74.0 10:22:21 INFO - PROCESS | 1679 | 10:22:21 INFO - PROCESS | 1679 | [#5] imaging-gaussian-blur Cycles:10 Average:101.30 Median:86.50 stddev:20.41 (23.6%) stddev-sans-first:21.16 10:22:21 INFO - PROCESS | 1679 | Values: 89.0 87.0 88.0 107.0 82.0 132.0 138.0 114.0 90.0 86.0 10:22:21 INFO - PROCESS | 1679 | 10:22:21 INFO - PROCESS | 1679 | [#6] imaging-darkroom Cycles:10 Average:108.80 Median:95.00 stddev:17.54 (18.5%) stddev-sans-first:13.89 10:22:21 INFO - PROCESS | 1679 | Values: 142.0 95.0 106.0 131.0 95.0 107.0 125.0 95.0 96.0 96.0 10:22:21 INFO - PROCESS | 1679 | 10:22:21 INFO - PROCESS | 1679 | [#7] imaging-desaturate Cycles:10 Average:101.60 Median:89.50 stddev:20.54 (22.9%) stddev-sans-first:21.09 10:22:21 INFO - PROCESS | 1679 | Values: 87.0 91.0 90.0 133.0 142.0 114.0 91.0 89.0 89.0 90.0 10:22:21 INFO - PROCESS | 1679 | 10:22:21 INFO - PROCESS | 1679 | [#8] json-parse-financial Cycles:10 Average:57.90 Median:57.00 stddev:5.04 (8.8%) stddev-sans-first:5.24 10:22:21 INFO - PROCESS | 1679 | Values: 55.0 56.0 56.0 56.0 57.0 72.0 57.0 57.0 55.0 58.0 10:22:21 INFO - PROCESS | 1679 | 10:22:21 INFO - PROCESS | 1679 | [#9] json-stringify-tinderbox Cycles:10 Average:81.30 Median:72.00 stddev:18.01 (25.0%) stddev-sans-first:18.44 10:22:21 INFO - PROCESS | 1679 | Values: 68.0 76.0 66.0 114.0 67.0 77.0 96.0 64.0 78.0 107.0 10:22:21 INFO - PROCESS | 1679 | 10:22:21 INFO - PROCESS | 1679 | [#10] stanford-crypto-aes Cycles:10 Average:95.40 Median:84.00 stddev:13.18 (15.7%) stddev-sans-first:13.92 10:22:21 INFO - PROCESS | 1679 | Values: 92.0 87.0 87.0 100.0 80.0 89.0 81.0 115.0 112.0 111.0 10:22:21 INFO - PROCESS | 1679 | 10:22:21 INFO - PROCESS | 1679 | [#11] stanford-crypto-ccm Cycles:10 Average:163.50 Median:164.00 stddev:14.02 (8.5%) stddev-sans-first:14.34 10:22:21 INFO - PROCESS | 1679 | Values: 153.0 146.0 150.0 166.0 162.0 161.0 168.0 172.0 196.0 161.0 10:22:21 INFO - PROCESS | 1679 | 10:22:21 INFO - PROCESS | 1679 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:203.00 Median:209.00 stddev:30.32 (14.5%) stddev-sans-first:30.89 10:22:21 INFO - PROCESS | 1679 | Values: 179.0 164.0 233.0 252.0 205.0 178.0 174.0 213.0 238.0 194.0 10:22:21 INFO - PROCESS | 1679 | 10:22:21 INFO - PROCESS | 1679 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:78.90 Median:74.00 stddev:12.90 (17.4%) stddev-sans-first:12.81 10:22:21 INFO - PROCESS | 1679 | Values: 66.0 70.0 85.0 100.0 91.0 95.0 78.0 67.0 70.0 67.0 10:22:21 INFO - PROCESS | 1679 | -------- Summary: end -------- 10:22:21 INFO - PROCESS | 1679 | 10:22:22 INFO - TEST-INFO | 1679: exit 0 10:22:22 INFO - TEST-OK | kraken | took 60986ms 10:22:22 INFO - SUITE-END | took 1175s 10:22:22 INFO - Completed test suite (00:19:35) 10:22:22 INFO - javascript benchmark 10:22:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7024.75555522485, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3223.790453620516, 3251.845594813841, 3273.328967561649, 3278.393497203017, 3284.573005509285, 4914.262860570916, 5110.671225481378, 5507.228987941691, 5537.0863807471715, 5587.916181257285, 5341.492558206974, 5421.322334708161, 5465.07093794055, 5481.479259470354, 5545.77816887325, 3686.889393318205, 4976.8506944791625, 5043.0, 5144.43411224765, 5193.16909294513, 466.5026704784701, 4598.954010459903, 4782.067496838118, 4992.0, 5052.141136006888, 4530.546945305459, 4629.749967508787, 4662.417197850269, 5087.135187018197, 5091.46539613339, 5068.113080210986, 5095.974520127413, 5117.283580298761, 5119.769610367543, 5149.30484384607, 4942.752862356903, 5024.296598476216, 5038.420581633122, 5102.566281866046, 5153.2270159476375, 4177.791110444496, 5397.8380648580605, 5427.43011983744, 5457.126859702468, 5523.2543606613, 5951.077582974646, 6019.247594050744, 6026.457618814284, 6042.154098426224, 6048.969755151196, 5842.5618078644275, 5943.524518038546, 6037.275526936795, 6117.327094019654, 6120.296165940929, 5628.212050312959, 5646.2942132233475, 5669.092945128759, 5702.0, 5713.800016999427, 6174.5060395168275, 6190.50475961922, 6191.4118158774845, 6193.318734939153, 6240.812775616739, 5632.7746890123935, 5708.372079071299, 5886.91092147954, 5952.375000624958, 5961.940380596138, 5952.851178720567, 6003.369646187088, 6007.579469437185, 6042.4561789438285, 6144.324124346318, 5072.797088116434, 5433.8369848904595, 5936.584439089309, 5940.70296485174, 5958.285005799332, 5786.247787787561, 5865.090910908816, 5894.970525147347, 5910.143029260733, 5964.761409543569, 3760.3795373763023, 4742.95257047432, 4779.856604301876, 4800.807967681323, 4804.2073057945745, 4039.2123535910214, 4325.84859529915, 4325.848595299212, 4331.7184383015, 4392.626626736763, 5134.820281290212, 5280.155175171954, 5513.807016754475, 5551.722413879371, 5710.600257981901, 6033.336333003366, 6059.7273122709585, 6084.239470066242, 6126.731429653714, 6139.43080903429, 5719.370869204384, 5725.77096916127, 5728.083506638918, 5739.454751798572, 5753.252077229933, 5078.187490001582, 5274.498922602346, 5274.973625131926, 5279.736013199325, 5280.551153152025, 6082.847928801727, 6096.9390306096375, 6104.398524058527, 6124.112003759519, 6158.538109641884, 6047.697615119138, 6054.66699331541, 6069.787557435468, 6071.301800292847, 6104.694765261808, 6098.969505152446, 6101.969490152521, 6113.17472141273, 6163.753449861955, 6195.783147589813, 5802.767889284381, 5829.912551311819, 5853.385394533683, 5863.501602363847, 5928.881422371443, 6043.516518678583, 6045.335013148462, 6060.575759696779, 6097.908531371944, 6100.2984656763265, 5656.745446454837, 5837.620554663933, 5841.269841269841, 5859.648421094748, 5861.296644402529, 4804.279358096313, 5614.578906581941, 5779.826605201851, 5806.158107074535, 5809.883802323845, 5585.525230355465, 5589.357223919302, 5710.486056254791, 5736.4550367715, 5749.108888122348, 5701.458361455655, 5838.4453476919625, 5846.912296315473, 5848.473637372657, 5885.941140588539, 4417.955820441883, 4890.9021819562695, 5134.9486505135965, 5636.943630563642, 5810.680412577349], "value": 5404.825225255066, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [454.9044700612871, 475.7549861821162, 497.30874085021804, 500.88479649680585, 528.4055437632663, 37311.81344093279, 39001.80499097504, 39017.219655606874, 39150.80424597873, 40554.59445405545, 39747.80126099373, 40183.799081004625, 40271.19457610846, 40314.0, 40322.59677403225, 9226.169644731974, 9438.197753190987, 9443.952780236124, 9467.763305917339, 9472.100150485727, 9348.859767103499, 9421.528923553795, 9444.858327125065, 9464.81070378592, 9469.715908522721, 9424.905750942471, 9476.336656434018, 9476.526173691287, 9485.098915603006, 9495.287853410988, 9375.10936461035, 9418.340716149873, 9433.622655093788, 9458.716238512856, 9465.952670236606, 9230.492322922237, 9306.906930930672, 9324.06759324069, 9333.486658233795, 9346.813063738755, 38615.69762501048, 38625.80687096546, 38768.61231387678, 38900.0, 38904.805475972724, 3219.307848812493, 3299.307145499448, 3319.3029463812386, 3709.4992176056426, 3921.607839216084, 29384.8530757347, 29638.851805740833, 30000.69999300001, 30487.932922347612, 30578.38843223123, 3144.308252184516, 3150.9684903150905, 3187.585613870205, 3203.167176534095, 3210.807351558914, 363408.0, 464706.6764666155, 468851.0, 469518.0, 471305.7216567017, 44511.33233001507, 54557.0, 54967.725161374736, 55010.0, 55204.447955520736, 56170.438295617336, 56579.15131273034, 56735.0, 56971.86056278934, 57199.42800571941, 14816.25918704082, 15012.47456339023, 15057.247137643293, 15245.6188595286, 15285.923570382078, 11949.283043017447, 12035.879641203652, 12044.87955120455, 12050.819237711441, 12067.517299308105, 12858.614241572768, 13964.441422343196, 14412.558744125503, 14892.925535372255, 14982.475613353481, 5491.050677009684, 6315.778947736807, 6614.7023383947835, 6650.501212409089, 6652.8669426611195, 807.382352500326, 902.2466240688967, 975.9902400976041, 978.6085565773748, 980.9705708828747, 21396.57206855854, 28251.43497130046, 28396.006139785008, 29203.7079629201, 29275.7072429273, 938.9483578403117, 1019.9592016319264, 1022.1822541966397, 1031.9845202321972, 1078.6116997880756, 15503.767443488357, 15754.527364179094, 15871.28579213938, 15990.0, 16160.43438479671, 642102.0, 642888.0, 648486.0, 649320.5339732994, 649709.0, 45055.77472112684, 48537.27194092092, 52316.73841630767, 52839.47160528423, 52850.73574632102, 1244.7074937389707, 1329.9958531308994, 1357.511295933463, 1358.110437663332, 1364.1814911053486, 28464.715352847034, 28622.427551448436, 28691.569626456036, 29141.0, 29234.0, 38964.610353896096, 44094.559054409045, 44806.0, 45179.77410112928, 45208.54791452044, 585117.0, 585838.0, 586240.2751944852, 587052.0, 588311.0, 23986.28041158768, 24053.63919541173, 24055.158069467485, 24453.943257092862, 24521.386965326008, 41899.7905010473, 42490.0, 42561.574384257, 42814.92962675958, 42856.78571607122, 34296.82851585726, 35061.47407788834, 35203.11992200215, 36059.45910811392, 36238.91283261401, 35158.82420587881, 35400.0, 35803.0, 36167.27665446729, 36355.63644363522, 34782.65217347896, 34827.0, 34880.30239395249, 34973.0, 35076.12309692278, 30088.345141017453, 30754.53868191934, 32289.0, 32298.677013229568, 32314.676853231165, 20497.795022049588, 23881.761182387952, 24019.759802401753, 24513.77431128472, 24526.509469810862], "value": 18781.811914038168, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.5088781033415, 374.8978004666281, 375.1016315923364, 379.709522215505, 395.1405692618554, 18487.378155461134, 18762.155702993365, 19475.805241947575, 19572.510687232825, 19793.703094453595, 18356.541086472844, 18779.718304225447, 18889.905550472264, 19237.134328955195, 19260.711089333636, 5089.669171503859, 5670.0, 5934.88130237395, 5937.67342796146, 5939.67331796751, 5662.6036177467595, 6275.215598050244, 6533.477321814267, 6585.0, 6592.6703664816805, 6281.968590157066, 6460.095586617877, 6531.542792004561, 6531.575447595915, 6551.0, 6244.781432649836, 6462.386073323027, 6489.156409666761, 6511.4465270452065, 6524.086627872101, 5546.805861794818, 5595.63628364155, 5602.24369710088, 5625.128105143709, 5625.296837895263, 21082.578348432944, 21087.578248434944, 22008.559828803332, 24343.513129737483, 24401.755982440125, 2114.4819519217735, 2116.11123328201, 2164.8701077935375, 2317.478567322356, 2375.239923224569, 14449.855501444956, 14818.555443336718, 14896.702065958729, 15079.924600377037, 15453.613659658486, 1780.6972814621545, 1830.3438707759417, 1866.6453373858924, 1879.1919474625906, 1897.9810201897942, 98533.53666158332, 109194.3620845688, 115594.84405155925, 119953.20070198954, 119979.40010299893, 9468.763280917894, 10220.233482488844, 10257.743556411, 10501.264911456125, 10506.159507239403, 13359.26524041187, 13396.933015335057, 13424.664383390493, 13454.0, 13686.52097176594, 6770.763023294161, 7010.369066784014, 7887.684492620346, 7902.209779022167, 8297.95851020741, 8088.514689118671, 8138.064122625856, 8258.339332853357, 8268.2558569729, 8468.44955077918, 4895.730734809548, 5405.324334458192, 5631.493165615032, 6447.065175549519, 6456.51576131792, 1616.1434439746954, 1646.8517833395051, 1664.7003539363031, 1828.5794267318324, 1843.0416183584462, 765.1330752962753, 902.4495058014605, 951.9143277105094, 979.0405402705388, 995.0149352141328, 16087.678246435005, 17130.48608541746, 21022.78977210208, 21416.78583214179, 21690.0, 884.7743825324501, 893.8972018217858, 941.6186444489992, 958.5111593087576, 975.4488713876636, 10635.52140153695, 11149.386783726974, 11265.436728163559, 11275.210735248455, 11341.603043893425, 576388.0, 577402.0, 579665.0, 592732.0, 594497.0, 116634.8336516641, 117398.41300793442, 119103.0, 119136.0, 122326.0, 971.2327261463506, 990.2177279948904, 1023.5598692562121, 1029.1920842138884, 1032.0453580438066, 13331.933340333237, 17240.396586119427, 18507.0, 18626.906865465586, 19051.523711907314, 49095.0, 49408.75295623499, 49857.50142498528, 51078.0, 51594.96810063702, 70413.64793176002, 71943.28056719575, 73767.63116184385, 74129.0, 82115.17884821075, 7341.265873412616, 7405.2224516425, 7409.703611855465, 7609.733659321897, 7799.844003120019, 9350.81298374015, 11075.612353567587, 11657.125715571197, 11762.705932351417, 12134.817977730518, 10026.849597256192, 10089.495525223563, 10107.0, 10198.031187037219, 10323.070923616911, 9758.46328451942, 9951.900480995097, 10060.446675432922, 10260.948695256477, 10273.84589231177, 8733.475991440533, 8988.370814042953, 10021.549030293509, 10312.587496500057, 10360.015798499131, 7137.607431591105, 7439.032925719838, 7600.80997975055, 7632.732854350071, 7747.418943579141, 7630.618469076635, 8912.86630700527, 9479.431234125974, 9863.802723945624, 10266.435346056038], "value": 9306.847105622799, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1285.7621340052092, 1418.43262694922, 1453.462218978978, 1715.7254839225718, 1769.6283780406113, 7624.35193008595, 7822.843543129134, 8051.91948080519, 8525.701600443987, 8557.828843423127, 7280.8179795505, 7559.979402780623, 8289.046759622644, 8402.411831171821, 8415.579221038954, 2301.2866011536435, 2330.4639932815376, 2331.25399872041, 2335.1243283768586, 2339.2046704120594, 1987.5826076523947, 2326.360250930999, 2358.2099996501192, 2358.9410264743433, 2374.3470545599926, 2296.689946857178, 2306.2965795432387, 2324.2910912171783, 2343.61330380487, 2347.6595893595418, 2265.76209498002, 2271.3867255840914, 2295.426143464142, 2297.8276629252873, 2303.2169062518656, 2286.2455389721354, 2352.752960939111, 2354.5761762882676, 2355.658429527726, 2357.10430036585, 8393.454425462325, 8458.323334133254, 8459.57702114898, 8468.407211495198, 8477.10990346011, 5099.566536844372, 5256.448072952323, 5262.210668399733, 5269.657472264291, 5274.472552744734, 3291.703746662788, 3459.9481007784902, 3546.858125674996, 3633.4731463937846, 3650.324689932371, 1020.5713600287897, 1049.422817450407, 1077.385890042676, 1081.1242893256488, 1096.0464395975473, 10950.780984380348, 10963.50664220104, 11062.834057489144, 11105.55577776888, 11214.775704485946, 4470.97167651442, 4627.583517483443, 4703.717776933327, 4765.785539650724, 4780.5697487225625, 9480.241580673668, 9492.857607135898, 9512.28657850664, 9513.857292140623, 9522.238220942309, 5232.3982741985155, 5236.869078273074, 5239.030779305841, 5250.684958902478, 5256.316678831728, 4305.5048669402795, 4316.460442444694, 4753.809847606126, 4790.784414701347, 4806.158922188603, 3109.518024706174, 3801.125741079567, 3842.289176502356, 3877.592852750477, 3903.902402439905, 1258.2764910176502, 1270.8602053774077, 1280.5390059578544, 1282.5318758653025, 1287.2855565161426, 836.9455985360933, 865.3250464637592, 866.8526350520426, 870.851955167623, 880.6257340630207, 5610.214569960209, 5642.351129620064, 5739.827805165852, 5789.565782566325, 6051.636901785907, 910.7040211931148, 913.1142791492242, 929.6932012436015, 946.6497395963538, 976.82417164911, 3259.0, 3634.236810269873, 3659.70722342212, 3933.7639741615594, 3942.6254505821903, 7805.141434442206, 8057.879131813028, 9085.863712044193, 9517.524123793783, 9906.7027989159, 8410.36922230835, 10120.342177758423, 10218.540165692562, 10221.284510084222, 10223.591056357662, 7709.5374277542405, 7791.376689864797, 7854.450188486865, 7875.803104922423, 7930.5638189898955, 5618.775248989995, 5719.170720245625, 5819.156222347651, 5910.674912879833, 5921.851953701192, 9427.9258563116, 9499.57251923679, 9546.952265238908, 9576.712698619052, 9584.472853993097, 9103.635854565744, 9498.905010949802, 9526.095020972996, 9572.856407154037, 9632.373895696757, 5455.699936503372, 6657.40083392497, 6866.793996179923, 6867.175938887365, 7353.852922941618, 7283.890741638774, 7980.361571074416, 8028.277455029075, 8075.959620202097, 8081.272685458337, 7108.537945033556, 7230.566166029845, 7248.855022899618, 7326.780196594111, 7366.594837284001, 7004.859902802017, 7096.077509923677, 7129.679164437716, 7202.207757146605, 7219.819504512219, 5624.57815663835, 6608.966955165193, 6735.292794256533, 6736.865262694817, 6738.191417029988, 4800.783964721526, 4859.489753575824, 4860.1251774680895, 4878.463369029475, 4966.652334336562, 4440.444944381952, 4709.599684026896, 4813.15769740301, 4868.050730107595, 4878.243872199815], "value": 4404.817821523552, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.4769375134142, 304.18781852453947, 311.6571771051843, 315.6275594798137, 317.8013741411618, 5114.360704911886, 5243.344581927249, 5384.6769193848395, 5518.779248830047, 5531.225628412026, 4524.868782804299, 5234.848333366663, 5370.462953704638, 5388.595855310858, 5438.7280635968245, 4139.275626765311, 4150.045489537408, 4169.312063509517, 4187.33002719565, 4192.107445862345, 3786.318462676717, 4083.3666533386586, 4157.916841663165, 4174.394712766647, 4194.909323575862, 3638.745287829853, 4047.793952295991, 4079.3897400800356, 4088.0393107619684, 4114.362273847559, 3623.9852841204242, 4051.9797401012806, 4068.7558746475156, 4089.9591004089875, 4110.362893751443, 2956.2609347663083, 3385.9334309692613, 3551.5560554930635, 3551.627079156677, 3584.4981702561663, 4939.518144556655, 5016.49835016499, 5293.682379057269, 5310.601704872111, 5357.598180136466, 3807.3908174691915, 4116.526599441043, 4356.738595684237, 4626.768661566942, 4671.299305104228, 4736.129228954544, 5082.99221807384, 5406.810761623325, 5488.890222195574, 5673.035583950697, 3495.94756078659, 3663.5454245655474, 3726.496922915399, 3817.6373244541724, 3897.337452633059, 4762.738049407281, 5150.819721309736, 5709.600327977043, 5958.255218097738, 6020.4280593343565, 3365.8148801815646, 3469.2541103662834, 3506.8071256080652, 3831.3103641344824, 3937.409388591677, 3845.769253844778, 3899.6100389961343, 3959.465472161279, 3983.1635356574866, 4010.1578668479365, 4464.464264288306, 4581.5647513486165, 4624.237000894882, 4634.467036290802, 4652.55800698933, 4874.195757699939, 5336.973315133399, 5748.770049198069, 5766.0, 5794.768209271582, 1142.628645690154, 1172.355204637463, 1198.0116403966763, 1261.7161138743709, 1268.5243033862303, 757.9848403031908, 766.2835249042164, 822.0915887943855, 845.471580262336, 846.5439444156042, 4520.4575450946095, 4999.850004499871, 5032.874178145576, 5048.242763585492, 5133.25567792668, 5542.224088627595, 5563.610547261653, 5590.105583106765, 5627.606067575231, 5632.592281669613, 4329.307310830252, 4392.407025051641, 4670.906581868411, 4694.647901407408, 5029.748512574357, 2529.3676580854785, 2569.7430256974526, 2724.9591256131175, 2915.4169166166853, 2951.276937150412, 5109.923351149736, 5412.3505179377935, 5549.916751248735, 5745.6552606843725, 5790.0, 4474.6420286377015, 4704.482506924235, 4926.472793434047, 5622.156676498476, 6092.878142437126, 5218.478152184751, 6062.666553339521, 6177.752889884444, 6198.776636149268, 6252.906206406908, 4719.451496192018, 5005.649604527648, 5724.942750572441, 5804.593678442468, 5944.73248703818, 4953.702777833341, 5687.60186786921, 5793.0, 5832.625530851861, 5911.231539899785, 4952.504749525018, 5938.7231745174995, 6131.693415329127, 6139.605553834098, 6152.0, 3579.6599323064265, 3641.1807343347537, 3979.621935916083, 3981.5222173339384, 4008.158286759813, 5524.309461317335, 5849.736761845642, 5928.970355148197, 5976.282846058501, 6008.819735407945, 4884.535969082932, 5542.418046105101, 5657.519110875622, 5818.214541036906, 5822.330432000204, 5390.975714614211, 5517.875617887062, 5535.0, 5765.538756899354, 5814.447627475383, 4699.553542413465, 5135.820246291362, 5345.0, 5701.489105386992, 5713.285839270091, 4646.629244372985, 5217.582593392595, 5468.4531546845, 5780.566457515619, 5806.709664516673, 5644.0, 5671.801486947937, 5699.945510080648, 5736.942630573808, 5765.740541675718], "value": 4063.865812854766, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [587.6650309323685, 674.8380388706711, 675.689182975831, 691.1153723234258, 691.7721045144867, 12179.269243845376, 13884.23636699981, 14667.48663796766, 14797.112173269585, 14818.703625927476, 13011.349432528383, 13231.536896208634, 13261.27063011534, 13457.0, 13468.191908485473, 823.300194834389, 836.113719457374, 840.6553313141613, 841.1210285251896, 843.8692002739585, 671.7145213284359, 678.3894494954556, 687.2508965227901, 849.2908421468081, 862.8490014247482, 735.4447392218867, 884.4693184089527, 885.5926273914007, 885.8006948436615, 891.8260939116875, 729.7263526177684, 881.7927786970057, 884.3234925282164, 884.995575022124, 887.968921087762, 664.1498881431775, 666.9695320729436, 667.2493444874516, 668.3951024322995, 669.6919417068154, 13375.0, 13768.311584420739, 13843.100198487065, 13858.514951976633, 13867.4453021879, 11160.720981975435, 12958.546450874173, 13310.733785324335, 13366.198028118344, 13452.1256118352, 11294.717632059183, 11380.317180969085, 11382.203245772716, 11394.430278486125, 11631.88368116325, 3603.225306559076, 3610.097475631092, 3613.5302410686704, 3619.5294611700574, 3626.5829429615405, 89653.55173224157, 91025.7243568916, 92108.0, 92915.07084929131, 92992.53503732574, 10142.391456512632, 10150.238732095122, 10189.388636681822, 10205.846912296322, 10581.89418105809, 20016.399508014783, 20121.39635810928, 20124.396268111686, 20345.62569047662, 20398.388048358574, 7252.601106939063, 7291.34377905991, 7372.336489715952, 7396.3713084387355, 7505.812354691177, 3793.867214647474, 4086.0602061526015, 4181.811818468176, 4245.936310955338, 4288.24955632763, 3272.672732726708, 3356.8992930212135, 3378.3074469733647, 3384.7630665853644, 3397.490376443553, 541.908055268634, 609.2082267794855, 618.9597676151036, 623.2956758862456, 629.5750368501243, 497.00102793385554, 552.5463673542085, 606.9696515174223, 641.9967900160469, 656.1601150527238, 6981.5112942093565, 7606.277403646644, 7742.61286935651, 8731.519766412908, 8820.250278726251, 592.925884264467, 636.48762745989, 641.5605310362416, 669.8727241824038, 706.4701473894579, 4086.182763447263, 4147.502299724052, 4225.239456897788, 4341.413909122291, 4407.0, 113475.0, 114077.42961285307, 122578.16132758016, 124353.0, 124941.0, 106112.0, 107993.46003270091, 109447.0, 110564.0, 112517.0, 95176.0, 96373.9999999986, 97577.51211243898, 98308.0, 98729.0, 8269.80087887265, 8278.83442331138, 8293.92179016748, 8327.0, 8499.660013599387, 55590.72204638951, 58900.0, 60009.69995149996, 60217.39782602118, 61511.0, 45514.54485455103, 52970.0, 62854.68572657107, 69454.0, 72443.55112897819, 11495.942520287344, 11782.293062416282, 11881.346525940811, 11977.820332695192, 12205.938970305091, 12608.87391126077, 13162.0, 13208.801867971795, 13269.800952985906, 14113.364898579382, 10930.562777489129, 11451.198416110792, 12121.575744848888, 12132.757344852876, 12661.74676506483, 11943.522259109886, 11981.28112313264, 12059.336736479227, 12069.456874440495, 12484.563040293546, 11147.777044459228, 11876.346800925687, 12035.037197024392, 12121.212121212093, 12491.812622810847, 8437.0, 9373.11858452883, 10076.89923100789, 10473.528691209067, 10486.947565262124, 10339.121174700234, 10590.947045264724, 10640.787184256425, 10642.521086550969, 10654.8401773975], "value": 7104.810363294348, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1611.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 117.0, 118.0, 116.0, 115.0, 116.0, 117.0, 117.0, 116.0, 117.0], "value": 115.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 121.0, 104.0, 186.0, 121.0, 113.0, 119.0, 118.0, 144.0, 116.0], "value": 128.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [201.0, 199.0, 206.0, 259.0, 193.0, 270.0, 275.0, 195.0, 193.0, 196.0], "value": 218.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 61.0, 79.0, 74.0, 76.0, 85.0, 85.0, 84.0, 94.0, 61.0], "value": 78.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 71.0, 87.0, 71.0, 55.0, 79.0, 123.0, 57.0, 94.0, 74.0], "value": 79.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 88.0, 107.0, 82.0, 132.0, 138.0, 114.0, 90.0, 86.0], "value": 101.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 95.0, 106.0, 131.0, 95.0, 107.0, 125.0, 95.0, 96.0, 96.0], "value": 108.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 91.0, 90.0, 133.0, 142.0, 114.0, 91.0, 89.0, 89.0, 90.0], "value": 101.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 56.0, 56.0, 57.0, 72.0, 57.0, 57.0, 55.0, 58.0], "value": 57.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 76.0, 66.0, 114.0, 67.0, 77.0, 96.0, 64.0, 78.0, 107.0], "value": 81.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 87.0, 87.0, 100.0, 80.0, 89.0, 81.0, 115.0, 112.0, 111.0], "value": 95.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 146.0, 150.0, 166.0, 162.0, 161.0, 168.0, 172.0, 196.0, 161.0], "value": 163.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 164.0, 233.0, 252.0, 205.0, 178.0, 174.0, 213.0, 238.0, 194.0], "value": 203.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 70.0, 85.0, 100.0, 91.0, 95.0, 78.0, 67.0, 70.0, 67.0], "value": 78.9, "unit": "score"}]}]} 10:22:22 INFO - Return code: 0 10:22:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:22:22 ERROR - # TBPL SUCCESS # 10:22:22 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:22:22 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:22:22 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:22:22 INFO - 2016-11-05 10:22:22.592 screenresolution[1684:12474] starting screenresolution argv=screenresolution get 10:22:22 INFO - 2016-11-05 10:22:22.595 screenresolution[1684:12474] Display 0: 1600x1200x32@60 10:22:22 INFO - 2016-11-05 10:22:22.601 screenresolution[1685:12477] starting screenresolution argv=screenresolution list 10:22:22 INFO - Available Modes on Display 0 10:22:22 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:22:22 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:22:22 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:22:22 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:22:22 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:22:22 INFO - Intel Iris: 10:22:22 INFO - Chipset Model: Intel Iris 10:22:22 INFO - Type: GPU 10:22:22 INFO - Bus: Built-In 10:22:22 INFO - VRAM (Dynamic, Max): 1536 MB 10:22:22 INFO - Vendor: Intel (0x8086) 10:22:22 INFO - Device ID: 0x0a2e 10:22:22 INFO - Revision ID: 0x0009 10:22:22 INFO - Displays: 10:22:22 INFO - Display: 10:22:22 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:22:22 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:22:22 INFO - Display Serial Number: 1600x1200 60 10:22:22 INFO - Main Display: Yes 10:22:22 INFO - Mirror: Off 10:22:22 INFO - Online: Yes 10:22:22 INFO - Rotation: Supported 10:22:22 INFO - Return code: 0 10:22:22 INFO - Running post-action listener: _resource_record_post_action 10:22:22 INFO - [mozharness: 2016-11-05 17:22:22.838987Z] Finished run-tests step (success) 10:22:22 INFO - Running post-run listener: _resource_record_post_run 10:22:22 INFO - Total resource usage - Wall time: 1210s; CPU: 55.0%; Read bytes: 32985600; Write bytes: 707218944; Read time: 197; Write time: 2015 10:22:22 INFO - TinderboxPrint: CPU usage
54.5% 10:22:22 INFO - TinderboxPrint: I/O read bytes / time
32,985,600 / 197 10:22:22 INFO - TinderboxPrint: I/O write bytes / time
707,218,944 / 2,015 10:22:22 INFO - TinderboxPrint: CPU idle
2,202.1 (45.5%) 10:22:22 INFO - TinderboxPrint: CPU system
979.5 (20.2%) 10:22:22 INFO - TinderboxPrint: CPU user
1,660.2 (34.3%) 10:22:22 INFO - TinderboxPrint: Swap in / out
431,161,344 / 0 10:22:22 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 395450880; Write bytes: 389998080; Read time: 29933; Write time: 816 10:22:22 INFO - run-tests - Wall time: 1177s; CPU: 55.0%; Read bytes: 30966272; Write bytes: 300967936; Read time: 180; Write time: 1151 10:22:23 INFO - Running post-run listener: _upload_blobber_files 10:22:23 INFO - Blob upload gear active. 10:22:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:22:23 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 10:22:23 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'] 10:22:23 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 10:22:23 INFO - (blobuploader) - INFO - Open directory for files ... 10:22:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:22:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:22:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:22:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:22:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:22:24 INFO - (blobuploader) - INFO - Done attempting. 10:22:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:22:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:22:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:22:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:22:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:22:25 INFO - (blobuploader) - INFO - Done attempting. 10:22:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:22:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:22:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:22:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:22:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:22:28 INFO - (blobuploader) - INFO - Done attempting. 10:22:28 INFO - (blobuploader) - INFO - Iteration through files over. 10:22:28 INFO - Return code: 0 10:22:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:22:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:22:28 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/66eb8d63a39ad4667ebd98bb9360934e9e86598e2d4b7b11bb7ed8e3e84da10ba4d6dc52b5ab2a24d59936622a188b9472a48ea3ec71d8bea65566b6c3009d72", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d161621637cff6b65db334bf569562d49327df10b0b1dfffd2437ee5bf0a1eff87efac846c9f9d354b9b0e683ab9c3280910d20a8959ae4136fa88f0ed8b30c4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/856b8ed1971d65028876d83d752a5e8a8084521ca76c05201244f1e8c1a25d7e88e8535a5f45b7ce02e31913c1b08d9dc959c6ae9f21cfc70a12960f9c604519"} 10:22:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:22:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:22:28 INFO - Contents: 10:22:28 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/66eb8d63a39ad4667ebd98bb9360934e9e86598e2d4b7b11bb7ed8e3e84da10ba4d6dc52b5ab2a24d59936622a188b9472a48ea3ec71d8bea65566b6c3009d72", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d161621637cff6b65db334bf569562d49327df10b0b1dfffd2437ee5bf0a1eff87efac846c9f9d354b9b0e683ab9c3280910d20a8959ae4136fa88f0ed8b30c4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/856b8ed1971d65028876d83d752a5e8a8084521ca76c05201244f1e8c1a25d7e88e8535a5f45b7ce02e31913c1b08d9dc959c6ae9f21cfc70a12960f9c604519"} 10:22:28 INFO - Running post-run listener: copy_logs_to_upload_dir 10:22:28 INFO - Copying logs to upload dir... 10:22:28 INFO - mkdir: /builds/slave/test/build/upload/logs 10:22:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.477381 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-11-05 10:22:28.667956) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-05 10:22:28.673332) ========= 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.bWsIxUsfhY/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.TT6j2k2N5K/Listeners TMPDIR=/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/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/66eb8d63a39ad4667ebd98bb9360934e9e86598e2d4b7b11bb7ed8e3e84da10ba4d6dc52b5ab2a24d59936622a188b9472a48ea3ec71d8bea65566b6c3009d72", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d161621637cff6b65db334bf569562d49327df10b0b1dfffd2437ee5bf0a1eff87efac846c9f9d354b9b0e683ab9c3280910d20a8959ae4136fa88f0ed8b30c4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/856b8ed1971d65028876d83d752a5e8a8084521ca76c05201244f1e8c1a25d7e88e8535a5f45b7ce02e31913c1b08d9dc959c6ae9f21cfc70a12960f9c604519"} build_url:https://queue.taskcluster.net/v1/task/c6Sy8-ibRsmMJ1f2aTyDRA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011208 build_url: 'https://queue.taskcluster.net/v1/task/c6Sy8-ibRsmMJ1f2aTyDRA/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/66eb8d63a39ad4667ebd98bb9360934e9e86598e2d4b7b11bb7ed8e3e84da10ba4d6dc52b5ab2a24d59936622a188b9472a48ea3ec71d8bea65566b6c3009d72", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d161621637cff6b65db334bf569562d49327df10b0b1dfffd2437ee5bf0a1eff87efac846c9f9d354b9b0e683ab9c3280910d20a8959ae4136fa88f0ed8b30c4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/856b8ed1971d65028876d83d752a5e8a8084521ca76c05201244f1e8c1a25d7e88e8535a5f45b7ce02e31913c1b08d9dc959c6ae9f21cfc70a12960f9c604519"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-05 10:22:28.706204) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-05 10:22:28.706528) ========= 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.bWsIxUsfhY/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.TT6j2k2N5K/Listeners TMPDIR=/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/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.004616 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-05 10:22:28.755036) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-05 10:22:28.755414) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-05 10:22:28.755760) ========= ========= Total master_lag: 0.18 =========