builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0080 starttime: 1493673992.01 results: success (0) buildid: 20170501133120 builduid: 0eb8b116fa2e4947a0788796d551850c revision: 8a7f650cff30f54e60e2a55f56c2e12222352f69 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-01 14:26:32.010426) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-01 14:26:32.011421) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-01 14:26:32.012101) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-01 14:26:32.041587) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-01 14:26:32.042246) ========= 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.QlGMfDEdKm/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.cTHoA5vUlU/Listeners TMPDIR=/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/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 --2017-05-01 14:26:32-- 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% 14.4M=0.001s 2017-05-01 14:26:32 (14.4 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.352101 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-01 14:26:32.421716) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-01 14:26:32.422073) ========= 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.QlGMfDEdKm/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.cTHoA5vUlU/Listeners TMPDIR=/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/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.027410 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-01 14:26:32.472554) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-01 14:26:32.472941) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 8a7f650cff30f54e60e2a55f56c2e12222352f69 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 8a7f650cff30f54e60e2a55f56c2e12222352f69 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.QlGMfDEdKm/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.cTHoA5vUlU/Listeners TMPDIR=/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/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 2017-05-01 14:26:32,570 truncating revision to first 12 chars 2017-05-01 14:26:32,571 Setting DEBUG logging. 2017-05-01 14:26:32,571 attempt 1/10 2017-05-01 14:26:32,571 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/8a7f650cff30?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-01 14:26:34,032 unpacking tar archive at: mozilla-beta-8a7f650cff30/testing/mozharness/ program finished with exit code 0 elapsedTime=1.734049 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-01 14:26:34.231162) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-01 14:26:34.231539) ========= script_repo_revision: 8a7f650cff30f54e60e2a55f56c2e12222352f69 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-01 14:26:34.231967) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-01 14:26:34.232264) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-01 14:26:34.256453) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2017-05-01 14:26:34.256794) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.QlGMfDEdKm/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.cTHoA5vUlU/Listeners TMPDIR=/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/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 14:26:34 INFO - MultiFileLogger online at 20170501 14:26:34 in /builds/slave/test 14:26:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 14:26:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:26:34 INFO - {'append_to_log': False, 14:26:34 INFO - 'base_work_dir': '/builds/slave/test', 14:26:34 INFO - 'blob_upload_branch': 'Mozilla-Beta', 14:26:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:26:34 INFO - 'branch': 'Mozilla-Beta', 14:26:34 INFO - 'buildbot_json_path': 'buildprops.json', 14:26:34 INFO - 'config_files': ('talos/mac_config.py',), 14:26:34 INFO - 'default_actions': ('clobber', 14:26:34 INFO - 'read-buildbot-config', 14:26:34 INFO - 'download-and-extract', 14:26:34 INFO - 'populate-webroot', 14:26:34 INFO - 'create-virtualenv', 14:26:34 INFO - 'install', 14:26:34 INFO - 'run-tests'), 14:26:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:26:34 INFO - 'download_minidump_stackwalk': True, 14:26:34 INFO - 'download_symbols': 'ondemand', 14:26:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:26:34 INFO - 'tooltool.py': '/tools/tooltool.py', 14:26:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:26:34 INFO - '/tools/misc-python/virtualenv.py')}, 14:26:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:26:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:26:34 INFO - 'gecko_profile': False, 14:26:34 INFO - 'gecko_profile_interval': 0, 14:26:34 INFO - 'installer_path': 'installer.exe', 14:26:34 INFO - 'log_level': 'info', 14:26:34 INFO - 'log_name': 'talos', 14:26:34 INFO - 'log_to_console': True, 14:26:34 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:26:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:26:34 INFO - 'opt_config_files': (), 14:26:34 INFO - 'pip_index': False, 14:26:34 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:26:34 INFO - 'cmd': ('bash', 14:26:34 INFO - '-c', 14:26:34 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:26:34 INFO - 'enabled': True, 14:26:34 INFO - 'halt_on_failure': False, 14:26:34 INFO - 'name': 'check_screen_resolution'},), 14:26:34 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:26:34 INFO - 'cmd': ('bash', 14:26:34 INFO - '-c', 14:26:34 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:26:34 INFO - 'enabled': True, 14:26:34 INFO - 'halt_on_failure': False, 14:26:34 INFO - 'name': 'check_screen_resolution'},), 14:26:34 INFO - 'run_cmd_checks_enabled': True, 14:26:34 INFO - 'suite': 'dromaeojs-e10s', 14:26:34 INFO - 'system_bits': '32', 14:26:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:26:34 INFO - 'title': 't-yosemite-r7-0080', 14:26:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:26:34 INFO - 'use_talos_json': True, 14:26:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:26:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:26:34 INFO - 'work_dir': 'build'} 14:26:34 INFO - [mozharness: 2017-05-01 21:26:34.466589Z] Running clobber step. 14:26:34 INFO - Running pre-action listener: _resource_record_pre_action 14:26:34 INFO - Running main action method: clobber 14:26:34 INFO - rmtree: /builds/slave/test/build 14:26:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:26:37 INFO - Running post-action listener: _resource_record_post_action 14:26:37 INFO - [mozharness: 2017-05-01 21:26:37.100160Z] Finished clobber step (success) 14:26:37 INFO - [mozharness: 2017-05-01 21:26:37.100241Z] Running read-buildbot-config step. 14:26:37 INFO - Running pre-action listener: _resource_record_pre_action 14:26:37 INFO - Running main action method: read_buildbot_config 14:26:37 INFO - Using buildbot properties: 14:26:37 INFO - { 14:26:37 INFO - "project": "", 14:26:37 INFO - "product": "firefox", 14:26:37 INFO - "script_repo_revision": "production", 14:26:37 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 14:26:37 INFO - "repository": "", 14:26:37 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 14:26:37 INFO - "buildid": "20170501133120", 14:26:37 INFO - "pgo_build": "False", 14:26:37 INFO - "basedir": "/builds/slave/test", 14:26:37 INFO - "buildnumber": 30, 14:26:37 INFO - "slavename": "t-yosemite-r7-0080", 14:26:37 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 14:26:37 INFO - "platform": "yosemite_r7", 14:26:37 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 14:26:37 INFO - "branch": "mozilla-beta", 14:26:37 INFO - "repo_path": "releases/mozilla-beta", 14:26:37 INFO - "revision": "8a7f650cff30f54e60e2a55f56c2e12222352f69", 14:26:37 INFO - "stage_platform": "macosx64", 14:26:37 INFO - "builduid": "0eb8b116fa2e4947a0788796d551850c", 14:26:37 INFO - "slavebuilddir": "test" 14:26:37 INFO - } 14:26:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/V1GB8lRYRWO1M3x2Ap3wCQ/artifacts/public/build/firefox-54.0.en-US.mac.dmg. 14:26:37 INFO - Running post-action listener: _resource_record_post_action 14:26:37 INFO - [mozharness: 2017-05-01 21:26:37.103578Z] Finished read-buildbot-config step (success) 14:26:37 INFO - [mozharness: 2017-05-01 21:26:37.103709Z] Running download-and-extract step. 14:26:37 INFO - Running pre-action listener: _resource_record_pre_action 14:26:37 INFO - Running main action method: download_and_extract 14:26:37 INFO - mkdir: /builds/slave/test/build/tests 14:26:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:26:37 INFO - trying https://queue.taskcluster.net/v1/task/V1GB8lRYRWO1M3x2Ap3wCQ/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json 14:26:37 INFO - Downloading https://queue.taskcluster.net/v1/task/V1GB8lRYRWO1M3x2Ap3wCQ/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 14:26:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/V1GB8lRYRWO1M3x2Ap3wCQ/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json'}, attempt #1 14:26:38 INFO - Downloaded 1165 bytes. 14:26:38 INFO - Reading from file /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 14:26:38 INFO - Using the following test package requirements: 14:26:38 INFO - {u'common': [u'firefox-54.0.en-US.mac.common.tests.zip'], 14:26:38 INFO - u'cppunittest': [u'firefox-54.0.en-US.mac.common.tests.zip', 14:26:38 INFO - u'firefox-54.0.en-US.mac.cppunittest.tests.zip'], 14:26:38 INFO - u'gtest': [u'firefox-54.0.en-US.mac.common.tests.zip', 14:26:38 INFO - u'firefox-54.0.en-US.mac.gtest.tests.zip'], 14:26:38 INFO - u'jittest': [u'firefox-54.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 14:26:38 INFO - u'mochitest': [u'firefox-54.0.en-US.mac.common.tests.zip', 14:26:38 INFO - u'firefox-54.0.en-US.mac.mochitest.tests.zip'], 14:26:38 INFO - u'mozbase': [u'firefox-54.0.en-US.mac.common.tests.zip'], 14:26:38 INFO - u'reftest': [u'firefox-54.0.en-US.mac.common.tests.zip', 14:26:38 INFO - u'firefox-54.0.en-US.mac.reftest.tests.zip'], 14:26:38 INFO - u'talos': [u'firefox-54.0.en-US.mac.common.tests.zip', 14:26:38 INFO - u'firefox-54.0.en-US.mac.talos.tests.zip'], 14:26:38 INFO - u'web-platform': [u'firefox-54.0.en-US.mac.common.tests.zip', 14:26:38 INFO - u'firefox-54.0.en-US.mac.web-platform.tests.zip'], 14:26:38 INFO - u'xpcshell': [u'firefox-54.0.en-US.mac.common.tests.zip', 14:26:38 INFO - u'firefox-54.0.en-US.mac.xpcshell.tests.zip']} 14:26:38 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip'] for test suite category: common 14:26:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/V1GB8lRYRWO1M3x2Ap3wCQ/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 14:26:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/V1GB8lRYRWO1M3x2Ap3wCQ/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 14:26:38 INFO - Fetch https://queue.taskcluster.net/v1/task/V1GB8lRYRWO1M3x2Ap3wCQ/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 14:26:39 INFO - Expected file size: 51225145 14:26:39 INFO - Obtained file size: 51225145 14:26:55 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip', u'firefox-54.0.en-US.mac.talos.tests.zip'] for test suite category: talos 14:26:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/V1GB8lRYRWO1M3x2Ap3wCQ/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 14:26:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/V1GB8lRYRWO1M3x2Ap3wCQ/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 14:26:55 INFO - Fetch https://queue.taskcluster.net/v1/task/V1GB8lRYRWO1M3x2Ap3wCQ/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 14:26:57 INFO - Expected file size: 51225145 14:26:57 INFO - Obtained file size: 51225145 14:27:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/V1GB8lRYRWO1M3x2Ap3wCQ/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip 14:27:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/V1GB8lRYRWO1M3x2Ap3wCQ/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip'}, attempt #1 14:27:12 INFO - Fetch https://queue.taskcluster.net/v1/task/V1GB8lRYRWO1M3x2Ap3wCQ/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip into memory 14:27:14 INFO - Expected file size: 14404449 14:27:14 INFO - Obtained file size: 14404449 14:27:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:27:14 INFO - trying https://queue.taskcluster.net/v1/task/V1GB8lRYRWO1M3x2Ap3wCQ/artifacts/public/build/firefox-54.0.en-US.mac.dmg 14:27:14 INFO - Downloading https://queue.taskcluster.net/v1/task/V1GB8lRYRWO1M3x2Ap3wCQ/artifacts/public/build/firefox-54.0.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0.en-US.mac.dmg 14:27:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/V1GB8lRYRWO1M3x2Ap3wCQ/artifacts/public/build/firefox-54.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg'}, attempt #1 14:27:16 INFO - Downloaded 59540457 bytes. 14:27:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/V1GB8lRYRWO1M3x2Ap3wCQ/artifacts/public/build/firefox-54.0.en-US.mac.dmg 14:27:16 INFO - mkdir: /builds/slave/test/properties 14:27:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:27:16 INFO - Writing to file /builds/slave/test/properties/build_url 14:27:16 INFO - Contents: 14:27:16 INFO - build_url:https://queue.taskcluster.net/v1/task/V1GB8lRYRWO1M3x2Ap3wCQ/artifacts/public/build/firefox-54.0.en-US.mac.dmg 14:27:17 INFO - Running post-action listener: _resource_record_post_action 14:27:17 INFO - Running post-action listener: set_extra_try_arguments 14:27:17 INFO - [mozharness: 2017-05-01 21:27:17.106047Z] Finished download-and-extract step (success) 14:27:17 INFO - [mozharness: 2017-05-01 21:27:17.106186Z] Running populate-webroot step. 14:27:17 INFO - Running pre-action listener: _resource_record_pre_action 14:27:17 INFO - Running main action method: populate_webroot 14:27:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:27:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:27:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:27:17 INFO - '--tppagecycles', 14:27:17 INFO - '7'], 14:27:17 INFO - 'tests': ['tsvgm']}}, 14:27:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:27:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:27:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:27:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:27:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:27:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:27:17 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 14:27:17 INFO - 'talos_options': ['--disable-e10s'], 14:27:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:27:17 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 14:27:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:27:17 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 14:27:17 INFO - 'talos_options': ['--disable-e10s'], 14:27:17 INFO - 'tests': ['damp', 'tps']}, 14:27:17 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 14:27:17 INFO - 'tests': ['damp', 'tps']}, 14:27:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:27:17 INFO - 'tests': ['dromaeo_dom']}, 14:27:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:27:17 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:27:17 INFO - 'tests': ['basic_compositor_video']}, 14:27:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:27:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:27:17 INFO - 'tests': ['a11yr', 14:27:17 INFO - 'ts_paint', 14:27:17 INFO - 'tpaint', 14:27:17 INFO - 'sessionrestore', 14:27:17 INFO - 'sessionrestore_no_auto_restore', 14:27:17 INFO - 'tabpaint']}, 14:27:17 INFO - 'other-e10s': {'tests': ['a11yr', 14:27:17 INFO - 'ts_paint', 14:27:17 INFO - 'tpaint', 14:27:17 INFO - 'sessionrestore', 14:27:17 INFO - 'sessionrestore_no_auto_restore', 14:27:17 INFO - 'tabpaint']}, 14:27:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:27:17 INFO - 'ts_paint', 14:27:17 INFO - 'tpaint', 14:27:17 INFO - 'sessionrestore', 14:27:17 INFO - 'sessionrestore_no_auto_restore', 14:27:17 INFO - 'tabpaint']}, 14:27:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:27:17 INFO - 'ts_paint', 14:27:17 INFO - 'tpaint', 14:27:17 INFO - 'sessionrestore', 14:27:17 INFO - 'sessionrestore_no_auto_restore', 14:27:17 INFO - 'tabpaint']}, 14:27:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:27:17 INFO - 'tests': ['a11yr', 14:27:17 INFO - 'ts_paint', 14:27:17 INFO - 'tpaint', 14:27:17 INFO - 'sessionrestore', 14:27:17 INFO - 'sessionrestore_no_auto_restore', 14:27:17 INFO - 'tabpaint']}, 14:27:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:27:17 INFO - 'tests': ['a11yr', 14:27:17 INFO - 'ts_paint', 14:27:17 INFO - 'tpaint', 14:27:17 INFO - 'sessionrestore', 14:27:17 INFO - 'sessionrestore_no_auto_restore', 14:27:17 INFO - 'tabpaint']}, 14:27:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:27:17 INFO - 'tests': ['tsvgx', 14:27:17 INFO - 'tsvgr_opacity', 14:27:17 INFO - 'tart', 14:27:17 INFO - 'tscrollx', 14:27:17 INFO - 'cart', 14:27:17 INFO - 'tsvg_static']}, 14:27:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:27:17 INFO - 'tsvgr_opacity', 14:27:17 INFO - 'tart', 14:27:17 INFO - 'tscrollx', 14:27:17 INFO - 'cart', 14:27:17 INFO - 'tsvg_static']}, 14:27:17 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 14:27:17 INFO - 'talos_options': ['--disable-e10s'], 14:27:17 INFO - 'tests': ['tp5o']}, 14:27:17 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 14:27:17 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 14:27:17 INFO - 'talos_options': ['--disable-e10s', 14:27:17 INFO - '--xperf_path', 14:27:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:27:17 INFO - 'tests': ['tp5n']}, 14:27:17 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 14:27:17 INFO - 'talos_options': ['--xperf_path', 14:27:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:27:17 INFO - 'tests': ['tp5n']}}, 14:27:17 INFO - 'talos.zip': {'path': '', 14:27:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:27:17 INFO - Running post-action listener: _resource_record_post_action 14:27:17 INFO - [mozharness: 2017-05-01 21:27:17.124718Z] Finished populate-webroot step (success) 14:27:17 INFO - [mozharness: 2017-05-01 21:27:17.124852Z] Running create-virtualenv step. 14:27:17 INFO - Running pre-action listener: _resource_record_pre_action 14:27:17 INFO - Running main action method: create_virtualenv 14:27:17 INFO - Creating virtualenv /builds/slave/test/build/venv 14:27:17 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 14:27:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:27:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:27:17 INFO - Using real prefix '/tools/python27' 14:27:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:27:17 INFO - Installing distribute.............................................................................................................................................................................................done. 14:27:20 INFO - Installing pip.................done. 14:27:20 INFO - Return code: 0 14:27:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:27:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:27:21 INFO - Reading from file tmpfile_stdout 14:27:21 INFO - Output received: 14:27:21 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) 14:27:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:27:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:27:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:27:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:27:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:27:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27:21 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 0x10b776b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b779768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe9359d5e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b554d30>, '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 0x10b47bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b549be8>, '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.QlGMfDEdKm/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.cTHoA5vUlU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/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 14:27:21 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 14:27:21 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 14:27:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QlGMfDEdKm/Render', 14:27:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:27:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:27:21 INFO - 'HOME': '/Users/cltbld', 14:27:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:27:21 INFO - 'LOGNAME': 'cltbld', 14:27:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:27:21 INFO - 'MOZ_NO_REMOTE': '1', 14:27:21 INFO - 'NO_EM_RESTART': '1', 14:27:21 INFO - 'PAGER': '/bin/cat', 14:27:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:27:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:27:21 INFO - 'PWD': '/builds/slave/test', 14:27:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:27:21 INFO - 'SHELL': '/bin/bash', 14:27:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cTHoA5vUlU/Listeners', 14:27:21 INFO - 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/', 14:27:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:27:21 INFO - 'USER': 'cltbld', 14:27:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:27:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:27:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:27:21 INFO - 'XPC_FLAGS': '0x0', 14:27:21 INFO - 'XPC_SERVICE_NAME': '0', 14:27:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:27:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:27:21 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 14:27:21 INFO - Cleaning up... 14:27:21 INFO - Return code: 0 14:27:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:27:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:27:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:27:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:27:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:27:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27:21 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 0x10b776b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b779768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe9359d5e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b554d30>, '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 0x10b47bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b549be8>, '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.QlGMfDEdKm/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.cTHoA5vUlU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/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 14:27:21 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 14:27:21 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 14:27:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QlGMfDEdKm/Render', 14:27:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:27:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:27:21 INFO - 'HOME': '/Users/cltbld', 14:27:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:27:21 INFO - 'LOGNAME': 'cltbld', 14:27:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:27:21 INFO - 'MOZ_NO_REMOTE': '1', 14:27:21 INFO - 'NO_EM_RESTART': '1', 14:27:21 INFO - 'PAGER': '/bin/cat', 14:27:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:27:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:27:21 INFO - 'PWD': '/builds/slave/test', 14:27:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:27:21 INFO - 'SHELL': '/bin/bash', 14:27:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cTHoA5vUlU/Listeners', 14:27:21 INFO - 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/', 14:27:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:27:21 INFO - 'USER': 'cltbld', 14:27:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:27:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:27:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:27:21 INFO - 'XPC_FLAGS': '0x0', 14:27:21 INFO - 'XPC_SERVICE_NAME': '0', 14:27:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:27:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:27:21 INFO - Downloading/unpacking psutil>=3.1.1 14:27:21 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 14:27:21 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 14:27:21 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 14:27:21 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 14:27:21 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 14:27:21 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 14:27:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:27:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:27:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:27:25 INFO - Installing collected packages: psutil 14:27:25 INFO - Running setup.py install for psutil 14:27:25 INFO - building 'psutil._psutil_osx' extension 14:27:25 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 14:27:25 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 14:27:26 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 14:27:26 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 14:27:26 INFO - building 'psutil._psutil_posix' extension 14:27:26 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 14:27:26 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:27:26 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:27:26 INFO - ^ 14:27:26 INFO - 1 warning generated. 14:27:26 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 14:27:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:27:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:27:26 INFO - Successfully installed psutil 14:27:26 INFO - Cleaning up... 14:27:26 INFO - Return code: 0 14:27:26 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:27:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:27:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:27:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:27:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:27:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b776b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b779768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe9359d5e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b554d30>, '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 0x10b47bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b549be8>, '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.QlGMfDEdKm/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.cTHoA5vUlU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/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 14:27:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:27:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 14:27:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QlGMfDEdKm/Render', 14:27:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:27:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:27:27 INFO - 'HOME': '/Users/cltbld', 14:27:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:27:27 INFO - 'LOGNAME': 'cltbld', 14:27:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:27:27 INFO - 'MOZ_NO_REMOTE': '1', 14:27:27 INFO - 'NO_EM_RESTART': '1', 14:27:27 INFO - 'PAGER': '/bin/cat', 14:27:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:27:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:27:27 INFO - 'PWD': '/builds/slave/test', 14:27:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:27:27 INFO - 'SHELL': '/bin/bash', 14:27:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cTHoA5vUlU/Listeners', 14:27:27 INFO - 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/', 14:27:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:27:27 INFO - 'USER': 'cltbld', 14:27:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:27:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:27:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:27:27 INFO - 'XPC_FLAGS': '0x0', 14:27:27 INFO - 'XPC_SERVICE_NAME': '0', 14:27:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:27:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:27:27 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:27:27 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 14:27:27 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 14:27:27 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 14:27:27 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 14:27:27 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 14:27:27 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 14:27:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:27:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:27:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:27:31 INFO - Installing collected packages: mozsystemmonitor 14:27:31 INFO - Running setup.py install for mozsystemmonitor 14:27:31 INFO - Successfully installed mozsystemmonitor 14:27:31 INFO - Cleaning up... 14:27:31 INFO - Return code: 0 14:27:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:27:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:27:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:27:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:27:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:27:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27:31 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 0x10b776b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b779768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe9359d5e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b554d30>, '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 0x10b47bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b549be8>, '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.QlGMfDEdKm/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.cTHoA5vUlU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/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 14:27:31 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 14:27:31 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 14:27:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QlGMfDEdKm/Render', 14:27:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:27:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:27:31 INFO - 'HOME': '/Users/cltbld', 14:27:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:27:31 INFO - 'LOGNAME': 'cltbld', 14:27:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:27:31 INFO - 'MOZ_NO_REMOTE': '1', 14:27:31 INFO - 'NO_EM_RESTART': '1', 14:27:31 INFO - 'PAGER': '/bin/cat', 14:27:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:27:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:27:31 INFO - 'PWD': '/builds/slave/test', 14:27:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:27:31 INFO - 'SHELL': '/bin/bash', 14:27:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cTHoA5vUlU/Listeners', 14:27:31 INFO - 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/', 14:27:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:27:31 INFO - 'USER': 'cltbld', 14:27:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:27:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:27:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:27:31 INFO - 'XPC_FLAGS': '0x0', 14:27:31 INFO - 'XPC_SERVICE_NAME': '0', 14:27:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:27:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:27:31 INFO - Downloading/unpacking jsonschema==2.5.1 14:27:31 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 14:27:31 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 14:27:31 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 14:27:31 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 14:27:31 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 14:27:31 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 14:27:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:27:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:27:34 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 14:27:34 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 14:27:34 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 14:27:34 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 14:27:34 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 14:27:34 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 14:27:34 INFO - Downloading functools32-3.2.3-2.tar.gz 14:27:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:27:34 INFO - warning: no files found matching '*.txt' 14:27:34 INFO - no previously-included directories found matching 'build' 14:27:34 INFO - no previously-included directories found matching 'dist' 14:27:34 INFO - no previously-included directories found matching '.git*' 14:27:34 INFO - Installing collected packages: jsonschema, functools32 14:27:34 INFO - Running setup.py install for functools32 14:27:34 INFO - warning: no files found matching '*.txt' 14:27:34 INFO - no previously-included directories found matching 'build' 14:27:34 INFO - no previously-included directories found matching 'dist' 14:27:34 INFO - no previously-included directories found matching '.git*' 14:27:34 INFO - Successfully installed jsonschema functools32 14:27:34 INFO - Cleaning up... 14:27:34 INFO - Return code: 0 14:27:34 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:27:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:27:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:27:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:27:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:27:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27:34 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 0x10b776b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b779768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe9359d5e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b554d30>, '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 0x10b47bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b549be8>, '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.QlGMfDEdKm/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.cTHoA5vUlU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/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 14:27:34 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 14:27:34 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 14:27:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QlGMfDEdKm/Render', 14:27:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:27:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:27:34 INFO - 'HOME': '/Users/cltbld', 14:27:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:27:34 INFO - 'LOGNAME': 'cltbld', 14:27:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:27:34 INFO - 'MOZ_NO_REMOTE': '1', 14:27:34 INFO - 'NO_EM_RESTART': '1', 14:27:34 INFO - 'PAGER': '/bin/cat', 14:27:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:27:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:27:34 INFO - 'PWD': '/builds/slave/test', 14:27:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:27:34 INFO - 'SHELL': '/bin/bash', 14:27:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cTHoA5vUlU/Listeners', 14:27:34 INFO - 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/', 14:27:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:27:34 INFO - 'USER': 'cltbld', 14:27:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:27:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:27:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:27:34 INFO - 'XPC_FLAGS': '0x0', 14:27:34 INFO - 'XPC_SERVICE_NAME': '0', 14:27:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:27:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:27:35 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:27:35 INFO - Cleaning up... 14:27:35 INFO - Return code: 0 14:27:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:27: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')]} 14:27:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:27:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27: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')]} 14:27:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:27:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27:35 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 0x10b776b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b779768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe9359d5e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b554d30>, '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 0x10b47bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b549be8>, '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.QlGMfDEdKm/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.cTHoA5vUlU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/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 14:27:35 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 14:27:35 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 14:27:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QlGMfDEdKm/Render', 14:27:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:27:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:27:35 INFO - 'HOME': '/Users/cltbld', 14:27:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:27:35 INFO - 'LOGNAME': 'cltbld', 14:27:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:27:35 INFO - 'MOZ_NO_REMOTE': '1', 14:27:35 INFO - 'NO_EM_RESTART': '1', 14:27:35 INFO - 'PAGER': '/bin/cat', 14:27:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:27:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:27:35 INFO - 'PWD': '/builds/slave/test', 14:27:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:27:35 INFO - 'SHELL': '/bin/bash', 14:27:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cTHoA5vUlU/Listeners', 14:27:35 INFO - 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/', 14:27:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:27:35 INFO - 'USER': 'cltbld', 14:27:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:27:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:27:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:27:35 INFO - 'XPC_FLAGS': '0x0', 14:27:35 INFO - 'XPC_SERVICE_NAME': '0', 14:27:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:27:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:27:35 INFO - Downloading/unpacking blobuploader==1.2.4 14:27:35 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 14:27:35 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 14:27:35 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 14:27:35 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 14:27:35 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 14:27:35 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 14:27:37 INFO - Downloading blobuploader-1.2.4.tar.gz 14:27:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:27:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:27:38 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 14:27:38 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 14:27:38 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 14:27:38 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 14:27:38 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 14:27:38 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 14:27:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:27:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:27:38 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 14:27:38 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 14:27:38 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 14:27:38 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 14:27:38 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 14:27:38 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 14:27:39 INFO - Downloading docopt-0.6.1.tar.gz 14:27:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:27:39 INFO - Installing collected packages: blobuploader, requests, docopt 14:27:39 INFO - Running setup.py install for blobuploader 14:27:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:27:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:27:39 INFO - Running setup.py install for requests 14:27:39 INFO - Running setup.py install for docopt 14:27:40 INFO - Successfully installed blobuploader requests docopt 14:27:40 INFO - Cleaning up... 14:27:40 INFO - Return code: 0 14:27:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:27:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:27:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:27:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:27:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:27:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27:40 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 0x10b776b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b779768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe9359d5e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b554d30>, '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 0x10b47bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b549be8>, '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.QlGMfDEdKm/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.cTHoA5vUlU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/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 14:27:40 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 14:27:40 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 14:27:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QlGMfDEdKm/Render', 14:27:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:27:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:27:40 INFO - 'HOME': '/Users/cltbld', 14:27:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:27:40 INFO - 'LOGNAME': 'cltbld', 14:27:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:27:40 INFO - 'MOZ_NO_REMOTE': '1', 14:27:40 INFO - 'NO_EM_RESTART': '1', 14:27:40 INFO - 'PAGER': '/bin/cat', 14:27:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:27:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:27:40 INFO - 'PWD': '/builds/slave/test', 14:27:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:27:40 INFO - 'SHELL': '/bin/bash', 14:27:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cTHoA5vUlU/Listeners', 14:27:40 INFO - 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/', 14:27:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:27:40 INFO - 'USER': 'cltbld', 14:27:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:27:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:27:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:27:40 INFO - 'XPC_FLAGS': '0x0', 14:27:40 INFO - 'XPC_SERVICE_NAME': '0', 14:27:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:27:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:27:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:27:40 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-MDEp6r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:27:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:27:40 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-K4IPG8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:27:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:27:40 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-90t0xI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:27:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:27:40 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-kwffnk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:27:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:27:40 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-lgFN8T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:27:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:27:41 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-dBJTEs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:27:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:27:41 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-GCHqbU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:27:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:27:41 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-6c4ZmE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:27:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:27:41 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-qayB07-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:27:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:27:41 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-A80yzS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:27:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:27:41 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-cbMQBu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:27:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:27:41 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-3popkj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:27:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:27:41 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-lnYRsP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:27:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:27:41 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-DeN8kl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:27:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:27:41 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-wLN6Wr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:27:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:27:42 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-GzcsMa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:27:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:27:42 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-_xV1vZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:27:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:27:42 INFO - Running setup.py install for manifestparser 14:27:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:27:42 INFO - Running setup.py install for mozcrash 14:27:42 INFO - Running setup.py install for mozdebug 14:27:42 INFO - Running setup.py install for mozdevice 14:27:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:27:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:27:42 INFO - Running setup.py install for mozfile 14:27:43 INFO - Running setup.py install for mozhttpd 14:27:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:27:43 INFO - Running setup.py install for mozinfo 14:27:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:27:43 INFO - Running setup.py install for mozInstall 14:27:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:27:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:27:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:27:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:27:43 INFO - Running setup.py install for mozleak 14:27:43 INFO - Running setup.py install for mozlog 14:27:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:27:43 INFO - Running setup.py install for moznetwork 14:27:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:27:43 INFO - Running setup.py install for mozprocess 14:27:44 INFO - Running setup.py install for mozprofile 14:27:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:27:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:27:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:27:44 INFO - Running setup.py install for mozrunner 14:27:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:27:44 INFO - Running setup.py install for mozscreenshot 14:27:44 INFO - Running setup.py install for moztest 14:27:44 INFO - Running setup.py install for mozversion 14:27:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:27:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:27:44 INFO - Cleaning up... 14:27:44 INFO - Return code: 0 14:27:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:27: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')]} 14:27:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:27:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27: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')]} 14:27:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:27:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27:44 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 0x10b776b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b779768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe9359d5e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b554d30>, '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 0x10b47bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b549be8>, '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.QlGMfDEdKm/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.cTHoA5vUlU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/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 14:27:44 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 14:27:44 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 14:27:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QlGMfDEdKm/Render', 14:27:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:27:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:27:44 INFO - 'HOME': '/Users/cltbld', 14:27:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:27:44 INFO - 'LOGNAME': 'cltbld', 14:27:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:27:44 INFO - 'MOZ_NO_REMOTE': '1', 14:27:44 INFO - 'NO_EM_RESTART': '1', 14:27:44 INFO - 'PAGER': '/bin/cat', 14:27:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:27:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:27:44 INFO - 'PWD': '/builds/slave/test', 14:27:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:27:44 INFO - 'SHELL': '/bin/bash', 14:27:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cTHoA5vUlU/Listeners', 14:27:44 INFO - 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/', 14:27:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:27:44 INFO - 'USER': 'cltbld', 14:27:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:27:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:27:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:27:44 INFO - 'XPC_FLAGS': '0x0', 14:27:44 INFO - 'XPC_SERVICE_NAME': '0', 14:27:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:27:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:27:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:27:45 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-OODviP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:27:45 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)) 14:27:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:27:45 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-ozf16J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:27:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 14:27:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:27:45 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-GvtFDf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:27:45 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)) 14:27:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:27:45 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-53ffYR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:27:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 14:27:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:27:45 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-zHjksN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:27:45 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)) 14:27:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:27:45 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-cC0Ia_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:27:45 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)) 14:27:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:27:45 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-R2Q2fR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:27:45 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)) 14:27:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:27:45 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-FQVROA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:27:46 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)) 14:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:27:46 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-Lqi_NQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:27:46 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)) 14:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:27:46 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-I0o0Wk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:27:46 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)) 14:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:27:46 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-Cla3K9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:27:46 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)) 14:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:27:46 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-1FASZ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:27:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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)) 14:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:27:46 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-JtFie2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:27:46 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)) 14:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:27:46 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-lLGRUb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:27:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 14:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:27:46 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-rC0do0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:27:46 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)) 14:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:27:46 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-ricxl3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:27:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 14:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:27:46 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-_RI5DO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:27:46 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)) 14:27:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:27:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:27:46 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)) 14:27:46 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:27:46 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:27:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:27:46 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 14:27:46 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 14:27:46 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 14:27:46 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 14:27:46 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 14:27:46 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 14:27:49 INFO - Downloading blessings-1.6.tar.gz 14:27:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:27:49 INFO - Installing collected packages: blessings 14:27:49 INFO - Running setup.py install for blessings 14:27:49 INFO - Successfully installed blessings 14:27:49 INFO - Cleaning up... 14:27:49 INFO - Return code: 0 14:27:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:27:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:27:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:27:50 INFO - Reading from file tmpfile_stdout 14:27:50 INFO - Current package versions: 14:27:50 INFO - blessings == 1.6 14:27:50 INFO - blobuploader == 1.2.4 14:27:50 INFO - docopt == 0.6.1 14:27:50 INFO - functools32 == 3.2.3-2 14:27:50 INFO - jsonschema == 2.5.1 14:27:50 INFO - manifestparser == 1.1 14:27:50 INFO - mozInstall == 1.12 14:27:50 INFO - mozcrash == 1.0 14:27:50 INFO - mozdebug == 0.1 14:27:50 INFO - mozdevice == 0.49 14:27:50 INFO - mozfile == 1.2 14:27:50 INFO - mozhttpd == 0.7 14:27:50 INFO - mozinfo == 0.9 14:27:50 INFO - mozleak == 0.1 14:27:50 INFO - mozlog == 3.4 14:27:50 INFO - moznetwork == 0.27 14:27:50 INFO - mozprocess == 0.25 14:27:50 INFO - mozprofile == 0.28 14:27:50 INFO - mozrunner == 6.13 14:27:50 INFO - mozscreenshot == 0.1 14:27:50 INFO - mozsystemmonitor == 0.3 14:27:50 INFO - moztest == 0.8 14:27:50 INFO - mozversion == 1.4 14:27:50 INFO - psutil == 3.1.1 14:27:50 INFO - requests == 1.2.3 14:27:50 INFO - wsgiref == 0.1.2 14:27:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:27:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:27:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:27:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:27:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:27:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27:50 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 0x10b776b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b779768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe9359d5e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b554d30>, '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 0x10b47bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b549be8>, '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.QlGMfDEdKm/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.cTHoA5vUlU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/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 14:27:50 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 14:27:50 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 14:27:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QlGMfDEdKm/Render', 14:27:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:27:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:27:50 INFO - 'HOME': '/Users/cltbld', 14:27:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:27:50 INFO - 'LOGNAME': 'cltbld', 14:27:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:27:50 INFO - 'MOZ_NO_REMOTE': '1', 14:27:50 INFO - 'NO_EM_RESTART': '1', 14:27:50 INFO - 'PAGER': '/bin/cat', 14:27:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:27:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:27:50 INFO - 'PWD': '/builds/slave/test', 14:27:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:27:50 INFO - 'SHELL': '/bin/bash', 14:27:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cTHoA5vUlU/Listeners', 14:27:50 INFO - 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/', 14:27:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:27:50 INFO - 'USER': 'cltbld', 14:27:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:27:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:27:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:27:50 INFO - 'XPC_FLAGS': '0x0', 14:27:50 INFO - 'XPC_SERVICE_NAME': '0', 14:27:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:27:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:27:50 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)) 14:27:50 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)) 14:27:50 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)) 14:27:50 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)) 14:27:50 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)) 14:27:50 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)) 14:27:50 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)) 14:27:50 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)) 14:27:50 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)) 14:27:50 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)) 14:27:50 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)) 14:27:50 INFO - Cleaning up... 14:27:50 INFO - Return code: 0 14:27:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:27:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:27:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:27:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:27:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:27:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27:50 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 0x10b776b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b779768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe9359d5e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b554d30>, '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 0x10b47bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b549be8>, '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.QlGMfDEdKm/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.cTHoA5vUlU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/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 14:27:50 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 14:27:50 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 14:27:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QlGMfDEdKm/Render', 14:27:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:27:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:27:50 INFO - 'HOME': '/Users/cltbld', 14:27:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:27:50 INFO - 'LOGNAME': 'cltbld', 14:27:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:27:50 INFO - 'MOZ_NO_REMOTE': '1', 14:27:50 INFO - 'NO_EM_RESTART': '1', 14:27:50 INFO - 'PAGER': '/bin/cat', 14:27:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:27:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:27:50 INFO - 'PWD': '/builds/slave/test', 14:27:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:27:50 INFO - 'SHELL': '/bin/bash', 14:27:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cTHoA5vUlU/Listeners', 14:27:50 INFO - 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/', 14:27:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:27:50 INFO - 'USER': 'cltbld', 14:27:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:27:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:27:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:27:50 INFO - 'XPC_FLAGS': '0x0', 14:27:50 INFO - 'XPC_SERVICE_NAME': '0', 14:27:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:27:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:27:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:27:50 INFO - Cleaning up... 14:27:50 INFO - Return code: 0 14:27:50 INFO - Running post-action listener: _resource_record_post_action 14:27:50 INFO - Running post-action listener: _start_resource_monitoring 14:27:50 INFO - Starting resource monitoring. 14:27:50 INFO - [mozharness: 2017-05-01 21:27:50.876205Z] Finished create-virtualenv step (success) 14:27:50 INFO - [mozharness: 2017-05-01 21:27:50.877226Z] Running install step. 14:27:50 INFO - Running pre-action listener: _resource_record_pre_action 14:27:50 INFO - Running main action method: install 14:27:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:27:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:27:51 INFO - Reading from file tmpfile_stdout 14:27:51 INFO - Detecting whether we're running mozinstall >=1.0... 14:27:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:27:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:27:51 INFO - Reading from file tmpfile_stdout 14:27:51 INFO - Output received: 14:27:51 INFO - Usage: mozinstall [options] installer 14:27:51 INFO - Options: 14:27:51 INFO - -h, --help show this help message and exit 14:27:51 INFO - -d DEST, --destination=DEST 14:27:51 INFO - Directory to install application into. [default: 14:27:51 INFO - "/builds/slave/test"] 14:27:51 INFO - --app=APP Application being installed. [default: firefox] 14:27:51 INFO - mkdir: /builds/slave/test/build/application 14:27:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 14:27:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0.en-US.mac.dmg --destination /builds/slave/test/build/application 14:28:05 INFO - Reading from file tmpfile_stdout 14:28:05 INFO - Output received: 14:28:05 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 14:28:05 INFO - Running post-action listener: _resource_record_post_action 14:28:05 INFO - [mozharness: 2017-05-01 21:28:05.907230Z] Finished install step (success) 14:28:05 INFO - [mozharness: 2017-05-01 21:28:05.907380Z] Running run-tests step. 14:28:05 INFO - Running pre-action listener: _resource_record_pre_action 14:28:05 INFO - Running main action method: run_tests 14:28:05 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:28:05 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:28:05 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:28:05 INFO - 2017-05-01 14:28:05.921 screenresolution[1621:7301] starting screenresolution argv=screenresolution get 14:28:05 INFO - 2017-05-01 14:28:05.924 screenresolution[1621:7301] Display 0: 1600x1200x32@60 14:28:05 INFO - 2017-05-01 14:28:05.930 screenresolution[1622:7303] starting screenresolution argv=screenresolution list 14:28:05 INFO - Available Modes on Display 0 14:28:05 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:28:05 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:28:05 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:28:05 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:28:06 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:28:06 INFO - Intel Iris: 14:28:06 INFO - Chipset Model: Intel Iris 14:28:06 INFO - Type: GPU 14:28:06 INFO - Bus: Built-In 14:28:06 INFO - VRAM (Dynamic, Max): 1536 MB 14:28:06 INFO - Vendor: Intel (0x8086) 14:28:06 INFO - Device ID: 0x0a2e 14:28:06 INFO - Revision ID: 0x0009 14:28:06 INFO - Displays: 14:28:06 INFO - Display: 14:28:06 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:28:06 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:28:06 INFO - Display Serial Number: 1600x1200 60 14:28:06 INFO - Main Display: Yes 14:28:06 INFO - Mirror: Off 14:28:06 INFO - Online: Yes 14:28:06 INFO - Rotation: Supported 14:28:06 INFO - Return code: 0 14:28:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:28:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:28:06 INFO - Python 2.7.3 14:28:06 INFO - Return code: 0 14:28:06 INFO - grabbing minidump binary from tooltool 14:28:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:28:06 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 0x10b554d30>, '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 0x10b47bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b549be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:28:06 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 14:28:06 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 14:28:06 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 14:28:06 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:28:06 INFO - Return code: 0 14:28:06 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:28:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:28:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:28:06 INFO - ENV: RUST_BACKTRACE is now 1 14:28:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:28:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:28:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/V1GB8lRYRWO1M3x2Ap3wCQ/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0080', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 14:28:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/V1GB8lRYRWO1M3x2Ap3wCQ/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0080 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 14:28:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QlGMfDEdKm/Render', 14:28:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:28:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:28:06 INFO - 'HOME': '/Users/cltbld', 14:28:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:28:06 INFO - 'LOGNAME': 'cltbld', 14:28:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:28:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:28:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:28:06 INFO - 'MOZ_NO_REMOTE': '1', 14:28:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:28:06 INFO - 'NO_EM_RESTART': '1', 14:28:06 INFO - 'PAGER': '/bin/cat', 14:28:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:28:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:28:06 INFO - 'PWD': '/builds/slave/test', 14:28:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:28:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:28:06 INFO - 'RUST_BACKTRACE': '1', 14:28:06 INFO - 'SHELL': '/bin/bash', 14:28:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cTHoA5vUlU/Listeners', 14:28:06 INFO - 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/', 14:28:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:28:06 INFO - 'USER': 'cltbld', 14:28:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:28:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:28:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:28:06 INFO - 'XPC_FLAGS': '0x0', 14:28:06 INFO - 'XPC_SERVICE_NAME': '0', 14:28:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:28:06 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/V1GB8lRYRWO1M3x2Ap3wCQ/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0080', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 14:28:06 INFO - mozversion application_buildid: 20170501133120 14:28:06 INFO - mozversion application_changeset: 8a7f650cff30f54e60e2a55f56c2e12222352f69 14:28:06 INFO - mozversion application_display_name: Firefox 14:28:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:28:06 INFO - mozversion application_name: Firefox 14:28:06 INFO - mozversion application_remotingname: firefox 14:28:06 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 14:28:06 INFO - mozversion application_vendor: Mozilla 14:28:06 INFO - mozversion application_version: 54.0 14:28:06 INFO - mozversion platform_buildid: 20170501133120 14:28:06 INFO - mozversion platform_changeset: 8a7f650cff30f54e60e2a55f56c2e12222352f69 14:28:06 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 14:28:06 INFO - mozversion platform_version: 54.0 14:28:06 INFO - using testdate: 1493674086 14:28:06 INFO - actual date: 1493674086 14:28:06 INFO - starting webserver on 'localhost:49229' 14:28:06 INFO - SUITE-START | Running 2 tests 14:28:06 INFO - TEST-START | dromaeo_css 14:28:06 INFO - operating with platform_type : mac_ 14:28:06 INFO - Initialising browser for dromaeo_css test... 14:28:06 INFO - TEST-INFO | started process 1632 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/tmpVwCq9B/profile http://localhost:49229/getInfo.html) 14:28:09 INFO - PROCESS | 1632 | 2017-05-01 14:28:09.585 plugin-container[1636:7480] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x494f, name = 'com.apple.tsm.portname' 14:28:09 INFO - PROCESS | 1632 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:28:09 INFO - PROCESS | 1632 | 2017-05-01 14:28:09.587 plugin-container[1636:7480] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x920b, name = 'com.apple.CFPasteboardClient' 14:28:09 INFO - PROCESS | 1632 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:28:09 INFO - PROCESS | 1632 | 2017-05-01 14:28:09.587 plugin-container[1636:7480] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:28:09 INFO - PROCESS | 1632 | __metrics Screen width/height:1600/1200 14:28:09 INFO - PROCESS | 1632 | colorDepth:24 14:28:09 INFO - PROCESS | 1632 | Browser inner width/height: 1024/689 14:28:09 INFO - PROCESS | 1632 | __metrics 14:28:09 ERROR - PROCESS | 1632 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3371: TypeError: this.tabs is undefined 14:28:10 INFO - TEST-INFO | 1632: exit 0 14:28:10 INFO - Browser initialized. 14:28:10 INFO - Running cycle 1/1 for dromaeo_css test... 14:28:10 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/tmpVwCq9B/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:28:12 INFO - PROCESS | 1637 | 2017-05-01 14:28:12.599 plugin-container[1638:7612] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x453f, name = 'com.apple.tsm.portname' 14:28:12 INFO - PROCESS | 1637 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:28:12 INFO - PROCESS | 1637 | 2017-05-01 14:28:12.599 plugin-container[1638:7612] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b03, name = 'com.apple.CFPasteboardClient' 14:28:12 INFO - PROCESS | 1637 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:28:12 INFO - PROCESS | 1637 | 2017-05-01 14:28:12.599 plugin-container[1638:7612] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:28:22 INFO - PROCESS | 1637 | RSS: Main: 174653440 14:28:22 INFO - PROCESS | 1637 | 14:31:25 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49229/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49229/tests/dromaeo/cssquery-ext.html) 14:31:26 INFO - PROCESS | 1637 | RSS: Main: 189624320 14:31:26 INFO - PROCESS | 1637 | 14:34:28 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49229/tests/dromaeo/cssquery-ext.html (next: http://localhost:49229/tests/dromaeo/cssquery-jquery.html) 14:34:29 INFO - PROCESS | 1637 | RSS: Main: 204115968 14:34:29 INFO - PROCESS | 1637 | 14:37:31 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49229/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49229/tests/dromaeo/cssquery-mootools.html) 14:37:32 INFO - PROCESS | 1637 | RSS: Main: 205488128 14:37:32 INFO - PROCESS | 1637 | 14:40:33 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49229/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49229/tests/dromaeo/cssquery-prototype.html) 14:40:34 INFO - PROCESS | 1637 | RSS: Main: 208613376 14:40:34 INFO - PROCESS | 1637 | 14:43:37 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49229/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49229/tests/dromaeo/cssquery-yui.html) 14:43:38 INFO - PROCESS | 1637 | RSS: Main: 210972672 14:43:38 INFO - PROCESS | 1637 | 14:46:41 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49229/tests/dromaeo/cssquery-yui.html (next: http://localhost:49229/tests/dromaeo/cssquery-dojo.html) 14:46:41 INFO - PROCESS | 1637 | RSS: Main: 209178624 14:46:41 INFO - PROCESS | 1637 | 14:46:41 INFO - PROCESS | 1637 | __start_tp_report 14:46:41 INFO - PROCESS | 1637 | _x_x_mozilla_page_load 14:46:41 INFO - PROCESS | 1637 | _x_x_mozilla_page_load_details 14:46:41 INFO - PROCESS | 1637 | |i|pagename|runs| 14:46:41 INFO - PROCESS | 1637 | |0;dojo.html;3592.443171308447;3596.1009747563107;3611.7291203159753;3633.164372194395;3653.1780349421383;6086.7565297388055;6129.509639228857;6177.814665560035;6206.875862482759;6219.253689557248;6162.198914141155;6199.938000619993;6227.844303892405;6234.781782637609;6247.593906396092;5446.400895901447;5530.391656917735;5546.084895992157;5599.244102046233;5614.887702245953;5580.246666699984;5599.076152434864;5607.719614019283;5614.157876318544;5628.127640215753;5340.305760251182;5375.865603359928;5583.441655834425;5586.190002449663;5640.605157638967;5499.422560631137;5515.393306736256;5517.531009864167;5525.419830917776;5545.667259964415;5454.045542030129;5510.421405752419;5548.639338442988;5552.278203833516;5552.805651802168;4923.975380123113;5768.961586914354;5902.557308201859;6263.498920086382;6303.873922521524;6334.493240540792;6337.8415539611415;6358.364163583651;6452.290248072755;6462.48300135988;6511.25120611131;6522.315156908504;6526.053722210253;6526.575772574815;6532.248791389004;6235.594686345373;6239.37606239377;6242.188515492957;6268.059791031382;6307.400796924285;6320.27316858558;6416.101745755598;6537.182852143482;6565.638889861008;6582.3746744059235;6398.520110991694;6398.840028999312;6406.8718625627225;6409.391107844747;6413.839654008687;6472.773452929125;6511.772087976993;6521.0544471051435;6522.836929076811;6524.608523488606;6286.4342209201395;6333.714982825784;6349.396807303298;6377.553571249968;6403.519736019817;6462.806115816533;6484.773032943825;6497.285298617148;6498.935010649833;6501.1548498694865;3932.803359832054;4381.430414046217;5228.398734145546;5273.841784746387;5313.123334649817;4672.042231342567;4695.483496815347;4748.643851711066;4756.357891684578;4786.712797232177;6128.747575574832;6203.8138855833495;6243.937560624427;6371.171747672865;6400.871982560416;6446.548741588043;6533.1180290661105;6558.868822623616;6566.868662626816;6596.076549283104;6329.778457753957;6337.683115844189;6355.841103972345;6365.708344995798;6391.105245265667;5584.134459158837;5603.019471592455;5761.625494342854;5774.191613174159;5783.971080144573;6689.096971908827;6724.865502689821;6846.863062738817;6851;6852.520323577502;6534.019897015486;6572.8356791080605;6581.440577550962;6601.306862779339;6645.9003114954285;6478.967605161944;6742.224644165787;6791.286914874065;6828.0440738297675;6850.520463567503;5094.2613321068975;6354.968225159029;6360.459360954371;6379.649119298483;6384.6169229846355;5459.099248623933;5859.853503662443;6402.423781859655;6442.581232219891;6481.481481481376;6345.7144428499905;6355.523335749745;6389.840253993501;6396.904046439214;6425.357464253537;6261.405166509175;6302.495800336053;6306.590071645328;6310.936890631035;6394.1687580614225;5795.971020145041;6242.250929888442;6339.936600634119;6373.171487706569;6377.489800816016;5841.883162336644;6097.603655762361;6381.266154392119;6389.137466441971;6395;5280.498352656491;6221.346758590283;6225.941589929632;6251.624902505864;6294.779682711266 14:46:41 INFO - PROCESS | 1637 | |1;ext.html;780.2353693380487;827.9586020698965;854.4787679515497;991.6628346362236;992.6128809764189;40801.79599102004;41202.17595648085;42591.36112958308;42670;42700.14599708008;41086.38370424446;41155.58844411555;41263.58736412635;41291.174176516455;41493.17013659725;8236.011678598561;8373.246407823295;11338.829917551202;11617.593384231554;11763.764724705501;11509.48207330672;11572.71068223297;11627.941860290686;11638.010769084638;11638.185327027111;11578.768424631502;11590.826137607943;11609.941950290278;11611.419429028558;11615.477303521362;10226.284160108795;11463.598774042868;11527.423628818526;11553.422328883522;11575;10539.63111291101;11308.547658093667;11342.262752921033;11362.37506937118;11394.772104557946;35914;36094.09764755902;36139.096522586886;36215.81892090549;36242.09394765126;3160.668129846356;3912.217556488714;3945.329294019995;3962.108525581721;4163.250614889319;21317;25956.09153679612;26458.86770566154;28271.85864070687;28302.716972830214;3283.737301015913;3292.407366673998;3313.9834300828343;3353.6814002669707;3364.192593777476;367217;369991;370073;371440;392695.99999999715;45921.77039114783;46197.53802461999;46387;46387.536124638995;46396;48092.27861582079;48096.27855582169;48113.278300825514;48188.75905620449;48315.06739730371;14698.191599461918;14737.336819843133;14764.926175369055;14767.335469903881;14780.852191477947;12608.432620532098;12657.43041563132;12823.166494177849;12825.166364186298;12835.294058826667;12307.4461649226;12319.384030798425;12332.81500777489;12356.25862448256;12378.876211237952;5880.470757631833;5890.911636325459;5919.1713160157615;5919.55603329752;5952.761889524457;1042.718466014187;1147.6671765188169;1166.5217260922982;1170.0288760328906;1186.9406529673654;26137.73862261353;26317.34206644849;27084.458310834067;27792.305192370353;27835;1111.4498323330004;1113.704868209925;1138.4194061028934;1146.3408540089315;1336.8997325200455;13597.728045439037;13920.30398480072;14139.575812725634;14251.57245282643;14323.641908952359;475589;523414;646438;648497;648928;43396.783016084715;52322.476775231764;52491.475085249425;52845.7357713209;53031.734841325546;1312.6390242683146;1457.9125252484885;1481.2889812889873;1490.1878476230481;1490.2548725637182;28300.71699282981;28717;28963.85518072396;29292.707072929;29604;37486.6251337494;41333.79333103315;44491.110177795614;44670;44699.55300446954;420744;423070;423221;424238;425424;31300.217494562818;31663.683363166074;31791.523127153574;32331.676683232865;32419.513707294882;41170.794146029075;41401.96495087647;41722.58277417187;42147.36778948257;42232.57767422409;24144.396390090387;29555.704442956154;29673.85163074171;30217;30418.543721843747;23914.88042559776;29431.85284073566;29722.811087557122;29772.873848246487;30087;33564.160895977795;33574.992750217534;34884.82557587196;35007.474887877215;35068.64931350654;25375.492490149725;25819.354516137246;25983.740162598133;29909;30521.694783051884;23177.956991935742;24472.14347497829;24537.509249815263;24755.876220618782;24916.37709057288 14:46:41 INFO - PROCESS | 1637 | |2;jquery.html;313.41235184029944;373.5629313702968;394.6487626012849;442.41601086565737;459.843493613562;20143.697844532344;21284.89357553212;22182.55634887301;22426.32721018368;22458.775412245872;22725.431864203405;22813.31560053197;23122.768772312273;23160.536789264206;23434.828258587087;6839.247682754893;6998.510104292702;7009.929900700979;7038.577685338871;7041.683124259395;6664.300248473914;6913.930860691404;6991.965040174792;7014;7014.614196219206;6277.654728989904;6671.166104236971;6992.265812089734;6998.720051197946;7010.894836577456;6807.693653785567;6856.6228857412825;6864.279250678682;6866.27904070073;6868.107146070979;6474.805755827286;6683.2648408675;6727.966360168168;6761.661916904184;6769.221539522969;26837.194884153505;27038.45923081547;27062.45875082507;27289.317767055785;27369.589456158174;2803.7616802571806;3027.3803515119307;3043.6956304369387;3078.5228289615147;3128.71841534263;16459.506214813573;16564.83435165657;17022.914885425616;17038;17604.38384656531;1799.8380145786812;2090.3728881335537;2125.532382875765;2156.1159924431063;2163.2212403534713;124363;133083.33458332648;134754;142190;142866;18317.450476485727;22330.665040024414;22709.432264193198;23367.298981030595;23467.882660586587;34821.651783481844;35007.824960875034;35275.64724352724;35811.20943952792;35837.82081089578;11089.112870970303;11308.321500709984;11495.137864660184;11499.712507187387;11725.710171881086;9302.25581953442;9315.208207302456;9321.860172097424;9493.288003399635;9589.184919281939;8274.586270686441;10311.84532232017;10448.007439293255;10547.367157970393;10551.15590752738;4394.143142087326;4432.645388368923;4452.198604251201;4470.6870519064005;4487.192305384997;942.4251206763869;948.393028461785;955.8948515663271;973.5813600151861;984.5084696684529;21026.2640807571;21856.781432185475;21912;21938.232161874577;21941.341759747233;997.7306127345576;998.4907697074544;1027.2655051637964;1031.4945676618554;1032.2413026425572;11378;11906.583269585697;11932.582359617372;11956.163068585116;11970.82043769344;781359;790183;796293;811905;826022;113626.43186784179;122774.15838762425;129341;133418.66581334255;139715;1309.155594641451;1314.78963365861;1336.5121730568274;1337.3447010964558;1344.4151793969654;18887.37966111749;20107.497312567302;20138.496537586092;20180.798192017894;20181.09185086645;52753.20870186874;53013;53081;53277.46722532725;58729;72907.63546182236;72941.27058729345;89912;91219;102298.48850755699;9944.701658950244;11828.40857957116;11859.644210673694;11892.881071189524;11957.342346170695;10392;13447.596572102853;13497.122687025312;13776.24230667323;13778.311084445939;11590.420478976186;11596.420178990847;11605.883941160819;11918.046556275303;11947.522099115939;10572.207084468542;10601.363918164934;10668.146548276274;10778.461076945965;10781.892181078403;10480.371177729055;11803;11820.40897955116;11988.700282493008;12081;11830.82253766177;12022.579209727968;12136.75726485483;12196.085293603193;12252;11633.47649355764;11769.293842369485;11787.292762434281;11844.993175580172;11912.642620721392 14:46:41 INFO - PROCESS | 1637 | |3;mootools.html;1564.5150003498914;1616.4988853455436;1648;1651.9917400412996;1667.691477076741;11335.319880807157;11569.826452603218;11978.520859165623;12075.939620301897;12076.852698993593;11492.023178029878;11685;11685.006774424184;11706.239094458855;11733.41332933352;2424.212131057405;2451.718052423976;2453.950920981579;2455.58255096634;2458.6434966929783;2379.357573455166;2437.9512409751796;2457.3856535866034;2457.950840983179;2462.2982450001755;2377.9048838046456;2412.8793560322;2414.311921102486;2455.533448644761;2457.8079631378855;2346.894389752448;2402.0511897800357;2408.663191928479;2410.3251089694913;2420.5037967216676;2401.2436082633913;2410.0600765701392;2419.6249581314923;2419.9637005444756;2424.4060205249652;11385.54457821686;11594.188406811527;11603.883961160365;11610.477528511237;11658.242214256132;5966.522678185735;6066.8786624267705;6122.571420000601;6152.538559608002;6155.384461553854;3613.4218525035867;3666.926661466782;3723.7579557328686;3741.7754934703735;3808.3525800613684;1290.9354532273442;1921.625283069802;1938.3797184900836;1977.2787265727359;2005.525938435249;12052.578159764455;13211.075224734272;14370.353334099991;15940.760888586565;16150.919245403815;4963.57809586182;5069.5437410632485;5135.563477104413;5227.059129356676;5228.764705588258;11366.886331136748;14000.579982600335;14104.012719109769;14127.64680882986;14157.292135393189;6297.811065668037;6337.493000559944;6338.7464501420345;6339.651319177397;6363.809085727436;5502.889942201134;5593.608447408642;5643.379228284885;5716.256886604798;5717.342505611825;4218.388333691598;4241.257779888569;4301.526832048472;4333.393324934512;4343.1747967886;1136.676047326508;1165.5046605192929;1174.9588764393377;1186.7033241689578;1188.0792385900822;991.5538007896475;1001.3140998415963;1014.1390548343871;1022.6880801355509;1036.6268143468346;6756.628385438848;6759.155105611799;6913.792586222421;7026.578405295699;7117;1006.2893081761035;1051.953306460077;1055.5988724284723;1065.8347956066823;1084.6908631040117;4054.8378064877074;4227;4269.338252570857;4469.486009108994;4588.7935042923145;10806.675799726021;14143.151410915378;14165.362558684885;14165.504207352693;14189.006769526033;13757.17456952586;13851;14113.08264962774;14222;14249.073810202304;10463.633772817915;10580.576776928836;10587.15302775776;10624.415657138932;10644.467776611138;6618.8345291368105;7007.019017337679;7028.789136325919;7207.13514378278;7352.264773522605;12255.448504817483;12402.441890114786;12565.685857853627;12587.055970802043;12616.17994830333;12586.307753073668;12733.61799146027;12841.550545730855;13010.414531345923;13047.673808154872;10303;10701.036906678437;10715.839262410915;10716.51775670081;10718.464076796285;10416.531256093645;10607.787844243227;10630.468476576294;10735;10754.89245107539;8606.311495080503;8705.738827835175;8727.389082764146;8891.555422228992;9191.816163676554;8763.211310982042;9049.819003620023;9055.411398259092;9066.773330666787;9136.725898223063;8325.625346859284;8389.790255243668;8522.91477085246;8528;8530.402871799162;6081.422264884829;6123.938760612515;6134.8159555213415;6287.622742635456;6288.308286088618;5842.737076831468;6206.627602343874;6240.719167637558;6265.122882796321;6396.744130234739 14:46:41 INFO - PROCESS | 1637 | |4;prototype.html;386.68485184574587;397.7966650881082;403.119184581689;403.42310495990756;409.0673264955902;4938.407391113072;5169.663971841827;5243.565464620679;5511.531519820815;5577.888442231153;4569.840055598055;4655.883602909929;4813.542713442226;5414.7546064405215;5489.505944464997;4155.376693495977;4702.8118875244945;4704.435467743876;4705.200115980291;4759.405074365704;3789.810509474529;3941.7634941903434;4509.932351014738;4645.163870503308;4661.86014419568;3972.7882995686305;4553.749543775091;4582.450105987286;4583.0522028138075;4662.834291427143;4078.5921407859273;4647.395838540985;4651.720896746206;4660.254359302496;4709.7174169549935;3340.682635149657;4295.935560966588;4434.756088415136;4464.888377790581;4485.9906521032835;4345;4927.334809800667;5061.114304996648;5115.488451154892;5197.790938850973;4241.003364209409;4376.3654270130655;5131.384233891919;5133.153029750087;5137.897242055138;5461.918071228934;5724.856878578027;5772.422757724236;5776.191333213354;5798.188253644493;4028.637422631948;4164.354525048622;4170.22850772608;4586.967932215258;4622.653301002405;5339.919901201485;5717.456841600041;5896.351401345849;5918.437748413894;5981.6840295135;4195.181939521825;4627.444706635225;4637.39713837199;4647.419072615923;4660.324252983299;4059.381698804255;4093.038136038029;4776.283557466408;4777.259524773665;4805.831795887197;4272.316429371285;4410.867673969786;4834.95165048352;5131.435542090367;5175.948240517622;4766.4995175506765;5055.292259083732;5322.308099946982;5612.550995920316;5673.290838645169;1456.1870471263344;1577.4005877766376;1628.3974929276244;1641.3352592200179;1643.0716645095483;1135.5344308833503;1140.9674244808461;1219.859716132656;1235.9432685054328;1260.489501751792;4642.029101375055;4763.428388593391;5250.291210686585;5289.920651190235;5369.355677318668;5062.468440813662;5308.0009794466005;5451.209574611738;5690.317161940511;5840.8247752567495;4402.273624851863;4786.664933454625;5293.550048245942;5375.946240537544;5467.20725494809;2826.4488424756973;2941.705829417084;2981.701829817001;3131.765117616188;3141.4502462069504;5643.714295710244;5666.393459008819;5937.7921772737745;5975.910361344583;6228;5270.973645131749;5342.824578592704;5420.945790542123;5552.611317207757;5717.571182161271;5040.974795126074;5425.37608175057;5908.20239267702;6241.656708881055;6249.999999999909;5021.44764075944;5084.542391184811;5290.867728306823;5348.934809544852;5612.579056570855;5711.8299343864555;5779.68211748341;5815.313559067823;5831.533477321719;5915.674637894957;5404.972975135099;5425.941941321405;5710.371859095413;5714.542836572981;5984.1921340618455;4232.32282834745;4250.298700714347;4314.274290283912;4658.697184682985;4684.812607495662;5270.60470464709;5621.426000719642;5863.589548731547;5909.468147866713;5959.344472108151;5213.627799351362;5727.742251598771;5818.970905145447;5847.912281315698;5851.502622277154;5264.842054738364;5387.3804512481565;5576.2174575043655;5637.4362563744935;5839.627687493351;4710.4818469967595;5262.947370526245;5469.535089517435;5623.325200975909;5630.549556035426;5352.547606793519;5376.274202982548;5506.697131657637;5569.777208911598;5770.460997161235;5056.797728090983;5240.3317677625055;5327.520523152934;5729.656220626775;5747.712614369181 14:46:41 INFO - PROCESS | 1637 | |5;yui.html;765.6363227466954;802.8816296112284;830.8795224692419;883.3198437203357;927.6845872403381;15915.44295949642;16988.83011169888;17008.23462944169;17215.05317207553;18106.637867242647;18205.544861378472;18613.255469781194;18626.72059919099;18636.72044919324;18759;1023.2121266624695;1052.0111095570178;1052.1267348101057;1052.978940421195;1053.4679986606752;1002.2933831648706;1031.9019693129142;1054.5307338234488;1056.862607860977;1059.4384975962753;1084.0460394852519;1086.0280049355822;1086.4296244471636;1086.869575650923;1087.33129125588;995.258532393368;1061.7611037516574;1072.1155047086106;1078.444601030466;1079.838024296362;800.9839803203962;809.5426084262373;813.7274013205583;815.4414226255034;816.9346452283803;17137.400190993256;17206.31174753021;17223.138843057797;17863.910680446643;18075;14659.340329685083;14907.552773416815;14910.478133265284;15104.848951510454;15237.542873713806;11457.94271028648;12087.93956030223;12108.939455302667;12228.144029917908;12764.042696797684;3864.961350386516;3879.262940041411;3880.980595097035;3920.882373528799;4013.3578627419474;123358.38320808428;125485.99999999908;126874;128877;131136.34431827778;9645.42127472354;11189.384583847805;11621.07031437483;11685.591004314978;11714.648560543197;24581.13966011181;24778.884950177286;24896.37759056038;24962.876670549867;24995.750042499705;8128.75613731589;8148.877766833502;8234.588270586446;8236.299914507334;8302.335813134934;4635.745034023161;4697.694649847749;4697.8355757548325;4766.928496072562;4770.499097594772;3640.1263696713127;3693.095191678056;3734.6825519830577;3738.5513738351574;3757.0982964088967;659.3047601605701;662.1127688896805;665.366298008851;671.3119052970744;671.9798406047729;717.3328804212028;723.1611330856286;727.828960194354;728.1553398058227;751.7894989402976;10705.304155229886;11051.613193538187;11100.777984440267;11227.494762735532;11280.864733891756;734.9816254593678;737.7973902538828;748.3900620993873;749.636426333228;752.3905636434506;5009.599232061426;5271.920921186185;5271.947280527145;5272.472752724773;5285.286486324374;87753;92837.53581232051;105514;106033.46983265188;113230;86322;89822;91001.54499227594;91570.54214728884;93705;70787;71424.64287678528;78655;78793;83780.58109709535;11248.156388270749;11307.208495405243;11324.37715925599;11525.711857203636;11670.474828632901;50501.49498505115;51827.74086129545;52655.73672131615;53240.73379633077;53783.462165377845;66690;67947.66026169837;68245.31754682589;68425.3157468419;70815.9377609326;13101.27942963108;13306.46774129024;13403.262820544574;13488;13496.595102146952;15228.695426091195;15332.616684582974;15436.228188590301;15465.458708945132;16321.591960200614;14194.92902535522;14258.215798131203;14417.855821441652;14531.200783956983;14905.850941490446;12406.937965310477;13599.388027538982;14348.282585870456;14514.491992780202;15012.849871501581;11545.88454115448;13022.739545209231;13269.469221231042;13692.65768355799;14261.786073208703;10060.748481288027;10102.563848104199;10120.949395252977;10206.489675516343;10243.641472548425;10674.573017079541;11088.168387370819;11450.198486106226;11825.822612660644;11985.700357491132 14:46:41 INFO - PROCESS | 1637 | __end_tp_report 14:46:41 INFO - PROCESS | 1637 | __start_cc_report 14:46:41 INFO - PROCESS | 1637 | _x_x_mozilla_cycle_collect,401 14:46:41 INFO - PROCESS | 1637 | __end_cc_report 14:46:41 INFO - PROCESS | 1637 | __startTimestamp1493675201389__endTimestamp 14:46:41 INFO - PROCESS | 1637 | 14:46:41 INFO - PROCESS | 1637 | ------- Summary: start ------- 14:46:41 INFO - PROCESS | 1637 | Number of tests: 6 14:46:41 INFO - PROCESS | 1637 | 14:46:41 INFO - PROCESS | 1637 | [#0] dojo.html Cycles:165 Average:6028.14 Median:6306.59 stddev:678.99 (10.8%) stddev-sans-first:653.64 14:46:41 INFO - PROCESS | 1637 | Values: 3592.4 3596.1 3611.7 3633.2 3653.2 6086.8 6129.5 6177.8 6206.9 6219.3 6162.2 6199.9 6227.8 6234.8 6247.6 5446.4 5530.4 5546.1 5599.2 5614.9 5580.2 5599.1 5607.7 5614.2 5628.1 5340.3 5375.9 5583.4 5586.2 5640.6 5499.4 5515.4 5517.5 5525.4 5545.7 5454.0 5510.4 5548.6 5552.3 5552.8 4924.0 5769.0 5902.6 6263.5 6303.9 6334.5 6337.8 6358.4 6452.3 6462.5 6511.3 6522.3 6526.1 6526.6 6532.2 6235.6 6239.4 6242.2 6268.1 6307.4 6320.3 6416.1 6537.2 6565.6 6582.4 6398.5 6398.8 6406.9 6409.4 6413.8 6472.8 6511.8 6521.1 6522.8 6524.6 6286.4 6333.7 6349.4 6377.6 6403.5 6462.8 6484.8 6497.3 6498.9 6501.2 3932.8 4381.4 5228.4 5273.8 5313.1 4672.0 4695.5 4748.6 4756.4 4786.7 6128.7 6203.8 6243.9 6371.2 6400.9 6446.5 6533.1 6558.9 6566.9 6596.1 6329.8 6337.7 6355.8 6365.7 6391.1 5584.1 5603.0 5761.6 5774.2 5784.0 6689.1 6724.9 6846.9 6851.0 6852.5 6534.0 6572.8 6581.4 6601.3 6645.9 6479.0 6742.2 6791.3 6828.0 6850.5 5094.3 6355.0 6360.5 6379.6 6384.6 5459.1 5859.9 6402.4 6442.6 6481.5 6345.7 6355.5 6389.8 6396.9 6425.4 6261.4 6302.5 6306.6 6310.9 6394.2 5796.0 6242.3 6339.9 6373.2 6377.5 5841.9 6097.6 6381.3 6389.1 6395.0 5280.5 6221.3 6225.9 6251.6 6294.8 14:46:41 INFO - PROCESS | 1637 | 14:46:41 INFO - PROCESS | 1637 | [#1] ext.html Cycles:180 Average:58896.35 Median:30317.77 stddev:126263.49 (416.5%) stddev-sans-first:126542.30 14:46:41 INFO - PROCESS | 1637 | Values: 780.2 828.0 854.5 991.7 992.6 40801.8 41202.2 42591.4 42670.0 42700.1 41086.4 41155.6 41263.6 41291.2 41493.2 8236.0 8373.2 11338.8 11617.6 11763.8 11509.5 11572.7 11627.9 11638.0 11638.2 11578.8 11590.8 11609.9 11611.4 11615.5 10226.3 11463.6 11527.4 11553.4 11575.0 10539.6 11308.5 11342.3 11362.4 11394.8 35914.0 36094.1 36139.1 36215.8 36242.1 3160.7 3912.2 3945.3 3962.1 4163.3 21317.0 25956.1 26458.9 28271.9 28302.7 3283.7 3292.4 3314.0 3353.7 3364.2 367217.0 369991.0 370073.0 371440.0 392696.0 45921.8 46197.5 46387.0 46387.5 46396.0 48092.3 48096.3 48113.3 48188.8 48315.1 14698.2 14737.3 14764.9 14767.3 14780.9 12608.4 12657.4 12823.2 12825.2 12835.3 12307.4 12319.4 12332.8 12356.3 12378.9 5880.5 5890.9 5919.2 5919.6 5952.8 1042.7 1147.7 1166.5 1170.0 1186.9 26137.7 26317.3 27084.5 27792.3 27835.0 1111.4 1113.7 1138.4 1146.3 1336.9 13597.7 13920.3 14139.6 14251.6 14323.6 475589.0 523414.0 646438.0 648497.0 648928.0 43396.8 52322.5 52491.5 52845.7 53031.7 1312.6 1457.9 1481.3 1490.2 1490.3 28300.7 28717.0 28963.9 29292.7 29604.0 37486.6 41333.8 44491.1 44670.0 44699.6 420744.0 423070.0 423221.0 424238.0 425424.0 31300.2 31663.7 31791.5 32331.7 32419.5 41170.8 41402.0 41722.6 42147.4 42232.6 24144.4 29555.7 29673.9 30217.0 30418.5 23914.9 29431.9 29722.8 29772.9 30087.0 33564.2 33575.0 34884.8 35007.5 35068.6 25375.5 25819.4 25983.7 29909.0 30521.7 23178.0 24472.1 24537.5 24755.9 24916.4 14:46:41 INFO - PROCESS | 1637 | 14:46:41 INFO - PROCESS | 1637 | [#2] jquery.html Cycles:180 Average:43466.24 Median:22256.61 stddev:132199.43 (594.0%) stddev-sans-first:132530.57 14:46:41 INFO - PROCESS | 1637 | Values: 313.4 373.6 394.6 442.4 459.8 20143.7 21284.9 22182.6 22426.3 22458.8 22725.4 22813.3 23122.8 23160.5 23434.8 6839.2 6998.5 7009.9 7038.6 7041.7 6664.3 6913.9 6992.0 7014.0 7014.6 6277.7 6671.2 6992.3 6998.7 7010.9 6807.7 6856.6 6864.3 6866.3 6868.1 6474.8 6683.3 6728.0 6761.7 6769.2 26837.2 27038.5 27062.5 27289.3 27369.6 2803.8 3027.4 3043.7 3078.5 3128.7 16459.5 16564.8 17022.9 17038.0 17604.4 1799.8 2090.4 2125.5 2156.1 2163.2 124363.0 133083.3 134754.0 142190.0 142866.0 18317.5 22330.7 22709.4 23367.3 23467.9 34821.7 35007.8 35275.6 35811.2 35837.8 11089.1 11308.3 11495.1 11499.7 11725.7 9302.3 9315.2 9321.9 9493.3 9589.2 8274.6 10311.8 10448.0 10547.4 10551.2 4394.1 4432.6 4452.2 4470.7 4487.2 942.4 948.4 955.9 973.6 984.5 21026.3 21856.8 21912.0 21938.2 21941.3 997.7 998.5 1027.3 1031.5 1032.2 11378.0 11906.6 11932.6 11956.2 11970.8 781359.0 790183.0 796293.0 811905.0 826022.0 113626.4 122774.2 129341.0 133418.7 139715.0 1309.2 1314.8 1336.5 1337.3 1344.4 18887.4 20107.5 20138.5 20180.8 20181.1 52753.2 53013.0 53081.0 53277.5 58729.0 72907.6 72941.3 89912.0 91219.0 102298.5 9944.7 11828.4 11859.6 11892.9 11957.3 10392.0 13447.6 13497.1 13776.2 13778.3 11590.4 11596.4 11605.9 11918.0 11947.5 10572.2 10601.4 10668.1 10778.5 10781.9 10480.4 11803.0 11820.4 11988.7 12081.0 11830.8 12022.6 12136.8 12196.1 12252.0 11633.5 11769.3 11787.3 11845.0 11912.6 14:46:41 INFO - PROCESS | 1637 | 14:46:41 INFO - PROCESS | 1637 | [#3] mootools.html Cycles:180 Average:7071.97 Median:2410.19 stddev:4332.11 (179.7%) stddev-sans-first:4324.50 14:46:41 INFO - PROCESS | 1637 | Values: 1564.5 1616.5 1648.0 1652.0 1667.7 11335.3 11569.8 11978.5 12075.9 12076.9 11492.0 11685.0 11685.0 11706.2 11733.4 2424.2 2451.7 2454.0 2455.6 2458.6 2379.4 2438.0 2457.4 2458.0 2462.3 2377.9 2412.9 2414.3 2455.5 2457.8 2346.9 2402.1 2408.7 2410.3 2420.5 2401.2 2410.1 2419.6 2420.0 2424.4 11385.5 11594.2 11603.9 11610.5 11658.2 5966.5 6066.9 6122.6 6152.5 6155.4 3613.4 3666.9 3723.8 3741.8 3808.4 1290.9 1921.6 1938.4 1977.3 2005.5 12052.6 13211.1 14370.4 15940.8 16150.9 4963.6 5069.5 5135.6 5227.1 5228.8 11366.9 14000.6 14104.0 14127.6 14157.3 6297.8 6337.5 6338.7 6339.7 6363.8 5502.9 5593.6 5643.4 5716.3 5717.3 4218.4 4241.3 4301.5 4333.4 4343.2 1136.7 1165.5 1175.0 1186.7 1188.1 991.6 1001.3 1014.1 1022.7 1036.6 6756.6 6759.2 6913.8 7026.6 7117.0 1006.3 1052.0 1055.6 1065.8 1084.7 4054.8 4227.0 4269.3 4469.5 4588.8 10806.7 14143.2 14165.4 14165.5 14189.0 13757.2 13851.0 14113.1 14222.0 14249.1 10463.6 10580.6 10587.2 10624.4 10644.5 6618.8 7007.0 7028.8 7207.1 7352.3 12255.4 12402.4 12565.7 12587.1 12616.2 12586.3 12733.6 12841.6 13010.4 13047.7 10303.0 10701.0 10715.8 10716.5 10718.5 10416.5 10607.8 10630.5 10735.0 10754.9 8606.3 8705.7 8727.4 8891.6 9191.8 8763.2 9049.8 9055.4 9066.8 9136.7 8325.6 8389.8 8522.9 8528.0 8530.4 6081.4 6123.9 6134.8 6287.6 6288.3 5842.7 6206.6 6240.7 6265.1 6396.7 14:46:41 INFO - PROCESS | 1637 | 14:46:41 INFO - PROCESS | 1637 | [#4] prototype.html Cycles:180 Average:4732.13 Median:5131.41 stddev:1299.83 (25.3%) stddev-sans-first:1261.89 14:46:41 INFO - PROCESS | 1637 | Values: 386.7 397.8 403.1 403.4 409.1 4938.4 5169.7 5243.6 5511.5 5577.9 4569.8 4655.9 4813.5 5414.8 5489.5 4155.4 4702.8 4704.4 4705.2 4759.4 3789.8 3941.8 4509.9 4645.2 4661.9 3972.8 4553.7 4582.5 4583.1 4662.8 4078.6 4647.4 4651.7 4660.3 4709.7 3340.7 4295.9 4434.8 4464.9 4486.0 4345.0 4927.3 5061.1 5115.5 5197.8 4241.0 4376.4 5131.4 5133.2 5137.9 5461.9 5724.9 5772.4 5776.2 5798.2 4028.6 4164.4 4170.2 4587.0 4622.7 5339.9 5717.5 5896.4 5918.4 5981.7 4195.2 4627.4 4637.4 4647.4 4660.3 4059.4 4093.0 4776.3 4777.3 4805.8 4272.3 4410.9 4835.0 5131.4 5175.9 4766.5 5055.3 5322.3 5612.6 5673.3 1456.2 1577.4 1628.4 1641.3 1643.1 1135.5 1141.0 1219.9 1235.9 1260.5 4642.0 4763.4 5250.3 5289.9 5369.4 5062.5 5308.0 5451.2 5690.3 5840.8 4402.3 4786.7 5293.6 5375.9 5467.2 2826.4 2941.7 2981.7 3131.8 3141.5 5643.7 5666.4 5937.8 5975.9 6228.0 5271.0 5342.8 5420.9 5552.6 5717.6 5041.0 5425.4 5908.2 6241.7 6250.0 5021.4 5084.5 5290.9 5348.9 5612.6 5711.8 5779.7 5815.3 5831.5 5915.7 5405.0 5425.9 5710.4 5714.5 5984.2 4232.3 4250.3 4314.3 4658.7 4684.8 5270.6 5621.4 5863.6 5909.5 5959.3 5213.6 5727.7 5819.0 5847.9 5851.5 5264.8 5387.4 5576.2 5637.4 5839.6 4710.5 5262.9 5469.5 5623.3 5630.5 5352.5 5376.3 5506.7 5569.8 5770.5 5056.8 5240.3 5327.5 5729.7 5747.7 14:46:41 INFO - PROCESS | 1637 | 14:46:41 INFO - PROCESS | 1637 | [#5] yui.html Cycles:180 Average:21688.65 Median:17210.68 stddev:31163.61 (181.1%) stddev-sans-first:31211.44 14:46:41 INFO - PROCESS | 1637 | Values: 765.6 802.9 830.9 883.3 927.7 15915.4 16988.8 17008.2 17215.1 18106.6 18205.5 18613.3 18626.7 18636.7 18759.0 1023.2 1052.0 1052.1 1053.0 1053.5 1002.3 1031.9 1054.5 1056.9 1059.4 1084.0 1086.0 1086.4 1086.9 1087.3 995.3 1061.8 1072.1 1078.4 1079.8 801.0 809.5 813.7 815.4 816.9 17137.4 17206.3 17223.1 17863.9 18075.0 14659.3 14907.6 14910.5 15104.8 15237.5 11457.9 12087.9 12108.9 12228.1 12764.0 3865.0 3879.3 3881.0 3920.9 4013.4 123358.4 125486.0 126874.0 128877.0 131136.3 9645.4 11189.4 11621.1 11685.6 11714.6 24581.1 24778.9 24896.4 24962.9 24995.8 8128.8 8148.9 8234.6 8236.3 8302.3 4635.7 4697.7 4697.8 4766.9 4770.5 3640.1 3693.1 3734.7 3738.6 3757.1 659.3 662.1 665.4 671.3 672.0 717.3 723.2 727.8 728.2 751.8 10705.3 11051.6 11100.8 11227.5 11280.9 735.0 737.8 748.4 749.6 752.4 5009.6 5271.9 5271.9 5272.5 5285.3 87753.0 92837.5 105514.0 106033.5 113230.0 86322.0 89822.0 91001.5 91570.5 93705.0 70787.0 71424.6 78655.0 78793.0 83780.6 11248.2 11307.2 11324.4 11525.7 11670.5 50501.5 51827.7 52655.7 53240.7 53783.5 66690.0 67947.7 68245.3 68425.3 70815.9 13101.3 13306.5 13403.3 13488.0 13496.6 15228.7 15332.6 15436.2 15465.5 16321.6 14194.9 14258.2 14417.9 14531.2 14905.9 12406.9 13599.4 14348.3 14514.5 15012.8 11545.9 13022.7 13269.5 13692.7 14261.8 10060.7 10102.6 10120.9 10206.5 10243.6 10674.6 11088.2 11450.2 11825.8 11985.7 14:46:41 INFO - PROCESS | 1637 | -------- Summary: end -------- 14:46:41 INFO - PROCESS | 1637 | 14:46:42 INFO - TEST-INFO | 1637: exit 0 14:46:42 INFO - TEST-OK | dromaeo_css | took 1115549ms 14:46:42 INFO - TEST-START | kraken 14:46:42 INFO - operating with platform_type : mac_ 14:46:42 INFO - Initialising browser for kraken test... 14:46:42 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/tmpaOIcpz/profile http://localhost:49229/getInfo.html) 14:46:44 INFO - PROCESS | 1649 | 2017-05-01 14:46:44.783 plugin-container[1651:10042] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4747, name = 'com.apple.tsm.portname' 14:46:44 INFO - PROCESS | 1649 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:46:44 INFO - PROCESS | 1649 | 2017-05-01 14:46:44.784 plugin-container[1651:10042] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d0b, name = 'com.apple.CFPasteboardClient' 14:46:44 INFO - PROCESS | 1649 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:46:44 INFO - PROCESS | 1649 | 2017-05-01 14:46:44.784 plugin-container[1651:10042] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:46:44 INFO - PROCESS | 1649 | __metrics Screen width/height:1600/1200 14:46:44 INFO - PROCESS | 1649 | colorDepth:24 14:46:44 INFO - PROCESS | 1649 | Browser inner width/height: 1024/689 14:46:44 INFO - PROCESS | 1649 | __metrics 14:46:44 ERROR - PROCESS | 1649 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3371: TypeError: this.tabs is undefined 14:46:45 INFO - TEST-INFO | 1649: exit 0 14:46:45 INFO - Browser initialized. 14:46:45 INFO - Running cycle 1/1 for kraken test... 14:46:45 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/tmpaOIcpz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:46:48 INFO - PROCESS | 1652 | 2017-05-01 14:46:48.355 plugin-container[1653:10164] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4647, name = 'com.apple.tsm.portname' 14:46:48 INFO - PROCESS | 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:46:48 INFO - PROCESS | 1652 | 2017-05-01 14:46:48.358 plugin-container[1653:10164] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8913, name = 'com.apple.CFPasteboardClient' 14:46:48 INFO - PROCESS | 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:46:48 INFO - PROCESS | 1652 | 2017-05-01 14:46:48.358 plugin-container[1653:10164] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:46:58 INFO - PROCESS | 1652 | RSS: Main: 174350336 14:46:58 INFO - PROCESS | 1652 | 14:47:01 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49229/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49229/tests/kraken/driver.html?testName=audio-beat-detection) 14:47:02 INFO - PROCESS | 1652 | RSS: Main: 188080128 14:47:02 INFO - PROCESS | 1652 | 14:47:04 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49229/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49229/tests/kraken/driver.html?testName=audio-dft) 14:47:05 INFO - PROCESS | 1652 | RSS: Main: 196136960 14:47:05 INFO - PROCESS | 1652 | 14:47:08 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49229/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49229/tests/kraken/driver.html?testName=audio-fft) 14:47:09 INFO - PROCESS | 1652 | RSS: Main: 200003584 14:47:09 INFO - PROCESS | 1652 | 14:47:11 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49229/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49229/tests/kraken/driver.html?testName=audio-oscillator) 14:47:12 INFO - PROCESS | 1652 | RSS: Main: 200769536 14:47:12 INFO - PROCESS | 1652 | 14:47:14 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49229/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49229/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:47:14 INFO - PROCESS | 1652 | RSS: Main: 201539584 14:47:14 INFO - PROCESS | 1652 | 14:47:17 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49229/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49229/tests/kraken/driver.html?testName=imaging-darkroom) 14:47:18 INFO - PROCESS | 1652 | RSS: Main: 205058048 14:47:18 INFO - PROCESS | 1652 | 14:47:21 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49229/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49229/tests/kraken/driver.html?testName=imaging-desaturate) 14:47:22 INFO - PROCESS | 1652 | RSS: Main: 204427264 14:47:22 INFO - PROCESS | 1652 | 14:47:25 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49229/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49229/tests/kraken/driver.html?testName=json-parse-financial) 14:47:26 INFO - PROCESS | 1652 | RSS: Main: 204693504 14:47:26 INFO - PROCESS | 1652 | 14:47:27 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49229/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49229/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:47:28 INFO - PROCESS | 1652 | RSS: Main: 204128256 14:47:28 INFO - PROCESS | 1652 | 14:47:30 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49229/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49229/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:47:30 INFO - PROCESS | 1652 | RSS: Main: 204173312 14:47:30 INFO - PROCESS | 1652 | 14:47:33 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49229/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49229/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:47:33 INFO - PROCESS | 1652 | RSS: Main: 204197888 14:47:33 INFO - PROCESS | 1652 | 14:47:36 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49229/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49229/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:47:37 INFO - PROCESS | 1652 | RSS: Main: 204574720 14:47:37 INFO - PROCESS | 1652 | 14:47:40 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49229/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49229/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:47:40 INFO - PROCESS | 1652 | RSS: Main: 204333056 14:47:40 INFO - PROCESS | 1652 | 14:47:42 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49229/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49229/tests/kraken/driver.html?testName=ai-astar) 14:47:42 INFO - PROCESS | 1652 | RSS: Main: 206450688 14:47:42 INFO - PROCESS | 1652 | 14:47:42 INFO - PROCESS | 1652 | __start_tp_report 14:47:42 INFO - PROCESS | 1652 | _x_x_mozilla_page_load 14:47:42 INFO - PROCESS | 1652 | _x_x_mozilla_page_load_details 14:47:42 INFO - PROCESS | 1652 | |i|pagename|runs| 14:47:42 INFO - PROCESS | 1652 | |0;ai-astar;107;121;119;138;176;175;120;143;176;146 14:47:42 INFO - PROCESS | 1652 | |1;audio-beat-detection;142;109;109;146;111;114;124;118;127;107 14:47:42 INFO - PROCESS | 1652 | |2;audio-dft;197;199;200;238;253;246;193;199;196;195 14:47:42 INFO - PROCESS | 1652 | |3;audio-fft;83;60;60;89;63;59;62;63;71;60 14:47:42 INFO - PROCESS | 1652 | |4;audio-oscillator;77;69;85;73;72;59;103;100;100;112 14:47:42 INFO - PROCESS | 1652 | |5;imaging-gaussian-blur;88;88;92;76;136;138;88;89;89;88 14:47:42 INFO - PROCESS | 1652 | |6;imaging-darkroom;95;100;95;120;155;95;96;95;154;95 14:47:42 INFO - PROCESS | 1652 | |7;imaging-desaturate;97;135;90;146;86;149;145;96;100;139 14:47:42 INFO - PROCESS | 1652 | |8;json-parse-financial;66;64;63;65;66;68;67;72;67;68 14:47:42 INFO - PROCESS | 1652 | |9;json-stringify-tinderbox;56;63;62;68;65;60;78;85;56;59 14:47:42 INFO - PROCESS | 1652 | |10;stanford-crypto-aes;81;85;91;107;80;85;83;81;86;81 14:47:42 INFO - PROCESS | 1652 | |11;stanford-crypto-ccm;169;151;136;154;140;116;144;164;207;168 14:47:42 INFO - PROCESS | 1652 | |12;stanford-crypto-pbkdf2;165;166;181;164;166;163;164;166;162;164 14:47:42 INFO - PROCESS | 1652 | |13;stanford-crypto-sha256-iterative;67;71;82;87;83;76;65;63;64;65 14:47:42 INFO - PROCESS | 1652 | __end_tp_report 14:47:42 INFO - PROCESS | 1652 | __start_cc_report 14:47:42 INFO - PROCESS | 1652 | _x_x_mozilla_cycle_collect,997 14:47:42 INFO - PROCESS | 1652 | __end_cc_report 14:47:42 INFO - PROCESS | 1652 | __startTimestamp1493675262826__endTimestamp 14:47:42 INFO - PROCESS | 1652 | 14:47:42 INFO - PROCESS | 1652 | ------- Summary: start ------- 14:47:42 INFO - PROCESS | 1652 | Number of tests: 14 14:47:42 INFO - PROCESS | 1652 | 14:47:42 INFO - PROCESS | 1652 | [#0] ai-astar Cycles:10 Average:142.10 Median:144.50 stddev:26.06 (18.0%) stddev-sans-first:24.35 14:47:42 INFO - PROCESS | 1652 | Values: 107.0 121.0 119.0 138.0 176.0 175.0 120.0 143.0 176.0 146.0 14:47:42 INFO - PROCESS | 1652 | 14:47:42 INFO - PROCESS | 1652 | [#1] audio-beat-detection Cycles:10 Average:120.70 Median:121.00 stddev:13.95 (11.5%) stddev-sans-first:12.49 14:47:42 INFO - PROCESS | 1652 | Values: 142.0 109.0 109.0 146.0 111.0 114.0 124.0 118.0 127.0 107.0 14:47:42 INFO - PROCESS | 1652 | 14:47:42 INFO - PROCESS | 1652 | [#2] audio-dft Cycles:10 Average:211.60 Median:199.50 stddev:23.86 (12.0%) stddev-sans-first:24.72 14:47:42 INFO - PROCESS | 1652 | Values: 197.0 199.0 200.0 238.0 253.0 246.0 193.0 199.0 196.0 195.0 14:47:42 INFO - PROCESS | 1652 | 14:47:42 INFO - PROCESS | 1652 | [#3] audio-fft Cycles:10 Average:67.00 Median:63.00 stddev:10.67 (16.9%) stddev-sans-first:9.61 14:47:42 INFO - PROCESS | 1652 | Values: 83.0 60.0 60.0 89.0 63.0 59.0 62.0 63.0 71.0 60.0 14:47:42 INFO - PROCESS | 1652 | 14:47:42 INFO - PROCESS | 1652 | [#4] audio-oscillator Cycles:10 Average:85.00 Median:70.50 stddev:17.68 (25.1%) stddev-sans-first:18.51 14:47:42 INFO - PROCESS | 1652 | Values: 77.0 69.0 85.0 73.0 72.0 59.0 103.0 100.0 100.0 112.0 14:47:42 INFO - PROCESS | 1652 | 14:47:42 INFO - PROCESS | 1652 | [#5] imaging-gaussian-blur Cycles:10 Average:97.20 Median:88.00 stddev:21.39 (24.3%) stddev-sans-first:22.43 14:47:42 INFO - PROCESS | 1652 | Values: 88.0 88.0 92.0 76.0 136.0 138.0 88.0 89.0 89.0 88.0 14:47:42 INFO - PROCESS | 1652 | 14:47:42 INFO - PROCESS | 1652 | [#6] imaging-darkroom Cycles:10 Average:110.00 Median:95.00 stddev:24.68 (26.0%) stddev-sans-first:25.57 14:47:42 INFO - PROCESS | 1652 | Values: 95.0 100.0 95.0 120.0 155.0 95.0 96.0 95.0 154.0 95.0 14:47:42 INFO - PROCESS | 1652 | 14:47:42 INFO - PROCESS | 1652 | [#7] imaging-desaturate Cycles:10 Average:118.30 Median:117.50 stddev:26.37 (22.4%) stddev-sans-first:26.82 14:47:42 INFO - PROCESS | 1652 | Values: 97.0 135.0 90.0 146.0 86.0 149.0 145.0 96.0 100.0 139.0 14:47:42 INFO - PROCESS | 1652 | 14:47:42 INFO - PROCESS | 1652 | [#8] json-parse-financial Cycles:10 Average:66.60 Median:67.00 stddev:2.50 (3.7%) stddev-sans-first:2.65 14:47:42 INFO - PROCESS | 1652 | Values: 66.0 64.0 63.0 65.0 66.0 68.0 67.0 72.0 67.0 68.0 14:47:42 INFO - PROCESS | 1652 | 14:47:42 INFO - PROCESS | 1652 | [#9] json-stringify-tinderbox Cycles:10 Average:65.20 Median:64.00 stddev:9.51 (14.9%) stddev-sans-first:9.48 14:47:42 INFO - PROCESS | 1652 | Values: 56.0 63.0 62.0 68.0 65.0 60.0 78.0 85.0 56.0 59.0 14:47:42 INFO - PROCESS | 1652 | 14:47:42 INFO - PROCESS | 1652 | [#10] stanford-crypto-aes Cycles:10 Average:86.00 Median:84.00 stddev:8.08 (9.6%) stddev-sans-first:8.37 14:47:42 INFO - PROCESS | 1652 | Values: 81.0 85.0 91.0 107.0 80.0 85.0 83.0 81.0 86.0 81.0 14:47:42 INFO - PROCESS | 1652 | 14:47:42 INFO - PROCESS | 1652 | [#11] stanford-crypto-ccm Cycles:10 Average:154.90 Median:159.00 stddev:24.48 (15.4%) stddev-sans-first:25.43 14:47:42 INFO - PROCESS | 1652 | Values: 169.0 151.0 136.0 154.0 140.0 116.0 144.0 164.0 207.0 168.0 14:47:42 INFO - PROCESS | 1652 | 14:47:42 INFO - PROCESS | 1652 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.10 Median:165.50 stddev:5.40 (3.3%) stddev-sans-first:5.72 14:47:42 INFO - PROCESS | 1652 | Values: 165.0 166.0 181.0 164.0 166.0 163.0 164.0 166.0 162.0 164.0 14:47:42 INFO - PROCESS | 1652 | 14:47:42 INFO - PROCESS | 1652 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.30 Median:73.50 stddev:9.01 (12.3%) stddev-sans-first:9.35 14:47:42 INFO - PROCESS | 1652 | Values: 67.0 71.0 82.0 87.0 83.0 76.0 65.0 63.0 64.0 65.0 14:47:42 INFO - PROCESS | 1652 | -------- Summary: end -------- 14:47:42 INFO - PROCESS | 1652 | 14:47:43 INFO - TEST-INFO | 1652: exit 0 14:47:43 INFO - TEST-OK | kraken | took 61612ms 14:47:43 INFO - SUITE-END | took 1177s 14:47:43 INFO - Completed test suite (00:19:37) 14:47:43 INFO - javascript benchmark 14:47:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7994.225923940173, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3592.443171308447, 3596.1009747563107, 3611.7291203159753, 3633.164372194395, 3653.1780349421383, 6086.7565297388055, 6129.509639228857, 6177.814665560035, 6206.875862482759, 6219.253689557248, 6162.198914141155, 6199.938000619993, 6227.844303892405, 6234.781782637609, 6247.593906396092, 5446.400895901447, 5530.391656917735, 5546.084895992157, 5599.244102046233, 5614.887702245953, 5580.246666699984, 5599.076152434864, 5607.719614019283, 5614.157876318544, 5628.127640215753, 5340.305760251182, 5375.865603359928, 5583.441655834425, 5586.190002449663, 5640.605157638967, 5499.422560631137, 5515.393306736256, 5517.531009864167, 5525.419830917776, 5545.667259964415, 5454.045542030129, 5510.421405752419, 5548.639338442988, 5552.278203833516, 5552.805651802168, 4923.975380123113, 5768.961586914354, 5902.557308201859, 6263.498920086382, 6303.873922521524, 6334.493240540792, 6337.8415539611415, 6358.364163583651, 6452.290248072755, 6462.48300135988, 6511.25120611131, 6522.315156908504, 6526.053722210253, 6526.575772574815, 6532.248791389004, 6235.594686345373, 6239.37606239377, 6242.188515492957, 6268.059791031382, 6307.400796924285, 6320.27316858558, 6416.101745755598, 6537.182852143482, 6565.638889861008, 6582.3746744059235, 6398.520110991694, 6398.840028999312, 6406.8718625627225, 6409.391107844747, 6413.839654008687, 6472.773452929125, 6511.772087976993, 6521.0544471051435, 6522.836929076811, 6524.608523488606, 6286.4342209201395, 6333.714982825784, 6349.396807303298, 6377.553571249968, 6403.519736019817, 6462.806115816533, 6484.773032943825, 6497.285298617148, 6498.935010649833, 6501.1548498694865, 3932.803359832054, 4381.430414046217, 5228.398734145546, 5273.841784746387, 5313.123334649817, 4672.042231342567, 4695.483496815347, 4748.643851711066, 4756.357891684578, 4786.712797232177, 6128.747575574832, 6203.8138855833495, 6243.937560624427, 6371.171747672865, 6400.871982560416, 6446.548741588043, 6533.1180290661105, 6558.868822623616, 6566.868662626816, 6596.076549283104, 6329.778457753957, 6337.683115844189, 6355.841103972345, 6365.708344995798, 6391.105245265667, 5584.134459158837, 5603.019471592455, 5761.625494342854, 5774.191613174159, 5783.971080144573, 6689.096971908827, 6724.865502689821, 6846.863062738817, 6851.0, 6852.520323577502, 6534.019897015486, 6572.8356791080605, 6581.440577550962, 6601.306862779339, 6645.9003114954285, 6478.967605161944, 6742.224644165787, 6791.286914874065, 6828.0440738297675, 6850.520463567503, 5094.2613321068975, 6354.968225159029, 6360.459360954371, 6379.649119298483, 6384.6169229846355, 5459.099248623933, 5859.853503662443, 6402.423781859655, 6442.581232219891, 6481.481481481376, 6345.7144428499905, 6355.523335749745, 6389.840253993501, 6396.904046439214, 6425.357464253537, 6261.405166509175, 6302.495800336053, 6306.590071645328, 6310.936890631035, 6394.1687580614225, 5795.971020145041, 6242.250929888442, 6339.936600634119, 6373.171487706569, 6377.489800816016, 5841.883162336644, 6097.603655762361, 6381.266154392119, 6389.137466441971, 6395.0, 5280.498352656491, 6221.346758590283, 6225.941589929632, 6251.624902505864, 6294.779682711266], "value": 5986.997020529963, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [780.2353693380487, 827.9586020698965, 854.4787679515497, 991.6628346362236, 992.6128809764189, 40801.79599102004, 41202.17595648085, 42591.36112958308, 42670.0, 42700.14599708008, 41086.38370424446, 41155.58844411555, 41263.58736412635, 41291.174176516455, 41493.17013659725, 8236.011678598561, 8373.246407823295, 11338.829917551202, 11617.593384231554, 11763.764724705501, 11509.48207330672, 11572.71068223297, 11627.941860290686, 11638.010769084638, 11638.185327027111, 11578.768424631502, 11590.826137607943, 11609.941950290278, 11611.419429028558, 11615.477303521362, 10226.284160108795, 11463.598774042868, 11527.423628818526, 11553.422328883522, 11575.0, 10539.63111291101, 11308.547658093667, 11342.262752921033, 11362.37506937118, 11394.772104557946, 35914.0, 36094.09764755902, 36139.096522586886, 36215.81892090549, 36242.09394765126, 3160.668129846356, 3912.217556488714, 3945.329294019995, 3962.108525581721, 4163.250614889319, 21317.0, 25956.09153679612, 26458.86770566154, 28271.85864070687, 28302.716972830214, 3283.737301015913, 3292.407366673998, 3313.9834300828343, 3353.6814002669707, 3364.192593777476, 367217.0, 369991.0, 370073.0, 371440.0, 392695.99999999715, 45921.77039114783, 46197.53802461999, 46387.0, 46387.536124638995, 46396.0, 48092.27861582079, 48096.27855582169, 48113.278300825514, 48188.75905620449, 48315.06739730371, 14698.191599461918, 14737.336819843133, 14764.926175369055, 14767.335469903881, 14780.852191477947, 12608.432620532098, 12657.43041563132, 12823.166494177849, 12825.166364186298, 12835.294058826667, 12307.4461649226, 12319.384030798425, 12332.81500777489, 12356.25862448256, 12378.876211237952, 5880.470757631833, 5890.911636325459, 5919.1713160157615, 5919.55603329752, 5952.761889524457, 1042.718466014187, 1147.6671765188169, 1166.5217260922982, 1170.0288760328906, 1186.9406529673654, 26137.73862261353, 26317.34206644849, 27084.458310834067, 27792.305192370353, 27835.0, 1111.4498323330004, 1113.704868209925, 1138.4194061028934, 1146.3408540089315, 1336.8997325200455, 13597.728045439037, 13920.30398480072, 14139.575812725634, 14251.57245282643, 14323.641908952359, 475589.0, 523414.0, 646438.0, 648497.0, 648928.0, 43396.783016084715, 52322.476775231764, 52491.475085249425, 52845.7357713209, 53031.734841325546, 1312.6390242683146, 1457.9125252484885, 1481.2889812889873, 1490.1878476230481, 1490.2548725637182, 28300.71699282981, 28717.0, 28963.85518072396, 29292.707072929, 29604.0, 37486.6251337494, 41333.79333103315, 44491.110177795614, 44670.0, 44699.55300446954, 420744.0, 423070.0, 423221.0, 424238.0, 425424.0, 31300.217494562818, 31663.683363166074, 31791.523127153574, 32331.676683232865, 32419.513707294882, 41170.794146029075, 41401.96495087647, 41722.58277417187, 42147.36778948257, 42232.57767422409, 24144.396390090387, 29555.704442956154, 29673.85163074171, 30217.0, 30418.543721843747, 23914.88042559776, 29431.85284073566, 29722.811087557122, 29772.873848246487, 30087.0, 33564.160895977795, 33574.992750217534, 34884.82557587196, 35007.474887877215, 35068.64931350654, 25375.492490149725, 25819.354516137246, 25983.740162598133, 29909.0, 30521.694783051884, 23177.956991935742, 24472.14347497829, 24537.509249815263, 24755.876220618782, 24916.37709057288], "value": 18992.731739417777, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [313.41235184029944, 373.5629313702968, 394.6487626012849, 442.41601086565737, 459.843493613562, 20143.697844532344, 21284.89357553212, 22182.55634887301, 22426.32721018368, 22458.775412245872, 22725.431864203405, 22813.31560053197, 23122.768772312273, 23160.536789264206, 23434.828258587087, 6839.247682754893, 6998.510104292702, 7009.929900700979, 7038.577685338871, 7041.683124259395, 6664.300248473914, 6913.930860691404, 6991.965040174792, 7014.0, 7014.614196219206, 6277.654728989904, 6671.166104236971, 6992.265812089734, 6998.720051197946, 7010.894836577456, 6807.693653785567, 6856.6228857412825, 6864.279250678682, 6866.27904070073, 6868.107146070979, 6474.805755827286, 6683.2648408675, 6727.966360168168, 6761.661916904184, 6769.221539522969, 26837.194884153505, 27038.45923081547, 27062.45875082507, 27289.317767055785, 27369.589456158174, 2803.7616802571806, 3027.3803515119307, 3043.6956304369387, 3078.5228289615147, 3128.71841534263, 16459.506214813573, 16564.83435165657, 17022.914885425616, 17038.0, 17604.38384656531, 1799.8380145786812, 2090.3728881335537, 2125.532382875765, 2156.1159924431063, 2163.2212403534713, 124363.0, 133083.33458332648, 134754.0, 142190.0, 142866.0, 18317.450476485727, 22330.665040024414, 22709.432264193198, 23367.298981030595, 23467.882660586587, 34821.651783481844, 35007.824960875034, 35275.64724352724, 35811.20943952792, 35837.82081089578, 11089.112870970303, 11308.321500709984, 11495.137864660184, 11499.712507187387, 11725.710171881086, 9302.25581953442, 9315.208207302456, 9321.860172097424, 9493.288003399635, 9589.184919281939, 8274.586270686441, 10311.84532232017, 10448.007439293255, 10547.367157970393, 10551.15590752738, 4394.143142087326, 4432.645388368923, 4452.198604251201, 4470.6870519064005, 4487.192305384997, 942.4251206763869, 948.393028461785, 955.8948515663271, 973.5813600151861, 984.5084696684529, 21026.2640807571, 21856.781432185475, 21912.0, 21938.232161874577, 21941.341759747233, 997.7306127345576, 998.4907697074544, 1027.2655051637964, 1031.4945676618554, 1032.2413026425572, 11378.0, 11906.583269585697, 11932.582359617372, 11956.163068585116, 11970.82043769344, 781359.0, 790183.0, 796293.0, 811905.0, 826022.0, 113626.43186784179, 122774.15838762425, 129341.0, 133418.66581334255, 139715.0, 1309.155594641451, 1314.78963365861, 1336.5121730568274, 1337.3447010964558, 1344.4151793969654, 18887.37966111749, 20107.497312567302, 20138.496537586092, 20180.798192017894, 20181.09185086645, 52753.20870186874, 53013.0, 53081.0, 53277.46722532725, 58729.0, 72907.63546182236, 72941.27058729345, 89912.0, 91219.0, 102298.48850755699, 9944.701658950244, 11828.40857957116, 11859.644210673694, 11892.881071189524, 11957.342346170695, 10392.0, 13447.596572102853, 13497.122687025312, 13776.24230667323, 13778.311084445939, 11590.420478976186, 11596.420178990847, 11605.883941160819, 11918.046556275303, 11947.522099115939, 10572.207084468542, 10601.363918164934, 10668.146548276274, 10778.461076945965, 10781.892181078403, 10480.371177729055, 11803.0, 11820.40897955116, 11988.700282493008, 12081.0, 11830.82253766177, 12022.579209727968, 12136.75726485483, 12196.085293603193, 12252.0, 11633.47649355764, 11769.293842369485, 11787.292762434281, 11844.993175580172, 11912.642620721392], "value": 11831.398933401008, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1564.5150003498914, 1616.4988853455436, 1648.0, 1651.9917400412996, 1667.691477076741, 11335.319880807157, 11569.826452603218, 11978.520859165623, 12075.939620301897, 12076.852698993593, 11492.023178029878, 11685.0, 11685.006774424184, 11706.239094458855, 11733.41332933352, 2424.212131057405, 2451.718052423976, 2453.950920981579, 2455.58255096634, 2458.6434966929783, 2379.357573455166, 2437.9512409751796, 2457.3856535866034, 2457.950840983179, 2462.2982450001755, 2377.9048838046456, 2412.8793560322, 2414.311921102486, 2455.533448644761, 2457.8079631378855, 2346.894389752448, 2402.0511897800357, 2408.663191928479, 2410.3251089694913, 2420.5037967216676, 2401.2436082633913, 2410.0600765701392, 2419.6249581314923, 2419.9637005444756, 2424.4060205249652, 11385.54457821686, 11594.188406811527, 11603.883961160365, 11610.477528511237, 11658.242214256132, 5966.522678185735, 6066.8786624267705, 6122.571420000601, 6152.538559608002, 6155.384461553854, 3613.4218525035867, 3666.926661466782, 3723.7579557328686, 3741.7754934703735, 3808.3525800613684, 1290.9354532273442, 1921.625283069802, 1938.3797184900836, 1977.2787265727359, 2005.525938435249, 12052.578159764455, 13211.075224734272, 14370.353334099991, 15940.760888586565, 16150.919245403815, 4963.57809586182, 5069.5437410632485, 5135.563477104413, 5227.059129356676, 5228.764705588258, 11366.886331136748, 14000.579982600335, 14104.012719109769, 14127.64680882986, 14157.292135393189, 6297.811065668037, 6337.493000559944, 6338.7464501420345, 6339.651319177397, 6363.809085727436, 5502.889942201134, 5593.608447408642, 5643.379228284885, 5716.256886604798, 5717.342505611825, 4218.388333691598, 4241.257779888569, 4301.526832048472, 4333.393324934512, 4343.1747967886, 1136.676047326508, 1165.5046605192929, 1174.9588764393377, 1186.7033241689578, 1188.0792385900822, 991.5538007896475, 1001.3140998415963, 1014.1390548343871, 1022.6880801355509, 1036.6268143468346, 6756.628385438848, 6759.155105611799, 6913.792586222421, 7026.578405295699, 7117.0, 1006.2893081761035, 1051.953306460077, 1055.5988724284723, 1065.8347956066823, 1084.6908631040117, 4054.8378064877074, 4227.0, 4269.338252570857, 4469.486009108994, 4588.7935042923145, 10806.675799726021, 14143.151410915378, 14165.362558684885, 14165.504207352693, 14189.006769526033, 13757.17456952586, 13851.0, 14113.08264962774, 14222.0, 14249.073810202304, 10463.633772817915, 10580.576776928836, 10587.15302775776, 10624.415657138932, 10644.467776611138, 6618.8345291368105, 7007.019017337679, 7028.789136325919, 7207.13514378278, 7352.264773522605, 12255.448504817483, 12402.441890114786, 12565.685857853627, 12587.055970802043, 12616.17994830333, 12586.307753073668, 12733.61799146027, 12841.550545730855, 13010.414531345923, 13047.673808154872, 10303.0, 10701.036906678437, 10715.839262410915, 10716.51775670081, 10718.464076796285, 10416.531256093645, 10607.787844243227, 10630.468476576294, 10735.0, 10754.89245107539, 8606.311495080503, 8705.738827835175, 8727.389082764146, 8891.555422228992, 9191.816163676554, 8763.211310982042, 9049.819003620023, 9055.411398259092, 9066.773330666787, 9136.725898223063, 8325.625346859284, 8389.790255243668, 8522.91477085246, 8528.0, 8530.402871799162, 6081.422264884829, 6123.938760612515, 6134.8159555213415, 6287.622742635456, 6288.308286088618, 5842.737076831468, 6206.627602343874, 6240.719167637558, 6265.122882796321, 6396.744130234739], "value": 5456.4351468599025, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [386.68485184574587, 397.7966650881082, 403.119184581689, 403.42310495990756, 409.0673264955902, 4938.407391113072, 5169.663971841827, 5243.565464620679, 5511.531519820815, 5577.888442231153, 4569.840055598055, 4655.883602909929, 4813.542713442226, 5414.7546064405215, 5489.505944464997, 4155.376693495977, 4702.8118875244945, 4704.435467743876, 4705.200115980291, 4759.405074365704, 3789.810509474529, 3941.7634941903434, 4509.932351014738, 4645.163870503308, 4661.86014419568, 3972.7882995686305, 4553.749543775091, 4582.450105987286, 4583.0522028138075, 4662.834291427143, 4078.5921407859273, 4647.395838540985, 4651.720896746206, 4660.254359302496, 4709.7174169549935, 3340.682635149657, 4295.935560966588, 4434.756088415136, 4464.888377790581, 4485.9906521032835, 4345.0, 4927.334809800667, 5061.114304996648, 5115.488451154892, 5197.790938850973, 4241.003364209409, 4376.3654270130655, 5131.384233891919, 5133.153029750087, 5137.897242055138, 5461.918071228934, 5724.856878578027, 5772.422757724236, 5776.191333213354, 5798.188253644493, 4028.637422631948, 4164.354525048622, 4170.22850772608, 4586.967932215258, 4622.653301002405, 5339.919901201485, 5717.456841600041, 5896.351401345849, 5918.437748413894, 5981.6840295135, 4195.181939521825, 4627.444706635225, 4637.39713837199, 4647.419072615923, 4660.324252983299, 4059.381698804255, 4093.038136038029, 4776.283557466408, 4777.259524773665, 4805.831795887197, 4272.316429371285, 4410.867673969786, 4834.95165048352, 5131.435542090367, 5175.948240517622, 4766.4995175506765, 5055.292259083732, 5322.308099946982, 5612.550995920316, 5673.290838645169, 1456.1870471263344, 1577.4005877766376, 1628.3974929276244, 1641.3352592200179, 1643.0716645095483, 1135.5344308833503, 1140.9674244808461, 1219.859716132656, 1235.9432685054328, 1260.489501751792, 4642.029101375055, 4763.428388593391, 5250.291210686585, 5289.920651190235, 5369.355677318668, 5062.468440813662, 5308.0009794466005, 5451.209574611738, 5690.317161940511, 5840.8247752567495, 4402.273624851863, 4786.664933454625, 5293.550048245942, 5375.946240537544, 5467.20725494809, 2826.4488424756973, 2941.705829417084, 2981.701829817001, 3131.765117616188, 3141.4502462069504, 5643.714295710244, 5666.393459008819, 5937.7921772737745, 5975.910361344583, 6228.0, 5270.973645131749, 5342.824578592704, 5420.945790542123, 5552.611317207757, 5717.571182161271, 5040.974795126074, 5425.37608175057, 5908.20239267702, 6241.656708881055, 6249.999999999909, 5021.44764075944, 5084.542391184811, 5290.867728306823, 5348.934809544852, 5612.579056570855, 5711.8299343864555, 5779.68211748341, 5815.313559067823, 5831.533477321719, 5915.674637894957, 5404.972975135099, 5425.941941321405, 5710.371859095413, 5714.542836572981, 5984.1921340618455, 4232.32282834745, 4250.298700714347, 4314.274290283912, 4658.697184682985, 4684.812607495662, 5270.60470464709, 5621.426000719642, 5863.589548731547, 5909.468147866713, 5959.344472108151, 5213.627799351362, 5727.742251598771, 5818.970905145447, 5847.912281315698, 5851.502622277154, 5264.842054738364, 5387.3804512481565, 5576.2174575043655, 5637.4362563744935, 5839.627687493351, 4710.4818469967595, 5262.947370526245, 5469.535089517435, 5623.325200975909, 5630.549556035426, 5352.547606793519, 5376.274202982548, 5506.697131657637, 5569.777208911598, 5770.460997161235, 5056.797728090983, 5240.3317677625055, 5327.520523152934, 5729.656220626775, 5747.712614369181], "value": 4357.245805354729, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [765.6363227466954, 802.8816296112284, 830.8795224692419, 883.3198437203357, 927.6845872403381, 15915.44295949642, 16988.83011169888, 17008.23462944169, 17215.05317207553, 18106.637867242647, 18205.544861378472, 18613.255469781194, 18626.72059919099, 18636.72044919324, 18759.0, 1023.2121266624695, 1052.0111095570178, 1052.1267348101057, 1052.978940421195, 1053.4679986606752, 1002.2933831648706, 1031.9019693129142, 1054.5307338234488, 1056.862607860977, 1059.4384975962753, 1084.0460394852519, 1086.0280049355822, 1086.4296244471636, 1086.869575650923, 1087.33129125588, 995.258532393368, 1061.7611037516574, 1072.1155047086106, 1078.444601030466, 1079.838024296362, 800.9839803203962, 809.5426084262373, 813.7274013205583, 815.4414226255034, 816.9346452283803, 17137.400190993256, 17206.31174753021, 17223.138843057797, 17863.910680446643, 18075.0, 14659.340329685083, 14907.552773416815, 14910.478133265284, 15104.848951510454, 15237.542873713806, 11457.94271028648, 12087.93956030223, 12108.939455302667, 12228.144029917908, 12764.042696797684, 3864.961350386516, 3879.262940041411, 3880.980595097035, 3920.882373528799, 4013.3578627419474, 123358.38320808428, 125485.99999999908, 126874.0, 128877.0, 131136.34431827778, 9645.42127472354, 11189.384583847805, 11621.07031437483, 11685.591004314978, 11714.648560543197, 24581.13966011181, 24778.884950177286, 24896.37759056038, 24962.876670549867, 24995.750042499705, 8128.75613731589, 8148.877766833502, 8234.588270586446, 8236.299914507334, 8302.335813134934, 4635.745034023161, 4697.694649847749, 4697.8355757548325, 4766.928496072562, 4770.499097594772, 3640.1263696713127, 3693.095191678056, 3734.6825519830577, 3738.5513738351574, 3757.0982964088967, 659.3047601605701, 662.1127688896805, 665.366298008851, 671.3119052970744, 671.9798406047729, 717.3328804212028, 723.1611330856286, 727.828960194354, 728.1553398058227, 751.7894989402976, 10705.304155229886, 11051.613193538187, 11100.777984440267, 11227.494762735532, 11280.864733891756, 734.9816254593678, 737.7973902538828, 748.3900620993873, 749.636426333228, 752.3905636434506, 5009.599232061426, 5271.920921186185, 5271.947280527145, 5272.472752724773, 5285.286486324374, 87753.0, 92837.53581232051, 105514.0, 106033.46983265188, 113230.0, 86322.0, 89822.0, 91001.54499227594, 91570.54214728884, 93705.0, 70787.0, 71424.64287678528, 78655.0, 78793.0, 83780.58109709535, 11248.156388270749, 11307.208495405243, 11324.37715925599, 11525.711857203636, 11670.474828632901, 50501.49498505115, 51827.74086129545, 52655.73672131615, 53240.73379633077, 53783.462165377845, 66690.0, 67947.66026169837, 68245.31754682589, 68425.3157468419, 70815.9377609326, 13101.27942963108, 13306.46774129024, 13403.262820544574, 13488.0, 13496.595102146952, 15228.695426091195, 15332.616684582974, 15436.228188590301, 15465.458708945132, 16321.591960200614, 14194.92902535522, 14258.215798131203, 14417.855821441652, 14531.200783956983, 14905.850941490446, 12406.937965310477, 13599.388027538982, 14348.282585870456, 14514.491992780202, 15012.849871501581, 11545.88454115448, 13022.739545209231, 13269.469221231042, 13692.65768355799, 14261.786073208703, 10060.748481288027, 10102.563848104199, 10120.949395252977, 10206.489675516343, 10243.641472548425, 10674.573017079541, 11088.168387370819, 11450.198486106226, 11825.822612660644, 11985.700357491132], "value": 8159.550528350804, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1563.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 121.0, 119.0, 138.0, 176.0, 175.0, 120.0, 143.0, 176.0, 146.0], "value": 142.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 109.0, 109.0, 146.0, 111.0, 114.0, 124.0, 118.0, 127.0, 107.0], "value": 120.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [197.0, 199.0, 200.0, 238.0, 253.0, 246.0, 193.0, 199.0, 196.0, 195.0], "value": 211.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 60.0, 60.0, 89.0, 63.0, 59.0, 62.0, 63.0, 71.0, 60.0], "value": 67.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 69.0, 85.0, 73.0, 72.0, 59.0, 103.0, 100.0, 100.0, 112.0], "value": 85.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 88.0, 92.0, 76.0, 136.0, 138.0, 88.0, 89.0, 89.0, 88.0], "value": 97.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 100.0, 95.0, 120.0, 155.0, 95.0, 96.0, 95.0, 154.0, 95.0], "value": 110.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 135.0, 90.0, 146.0, 86.0, 149.0, 145.0, 96.0, 100.0, 139.0], "value": 118.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 63.0, 65.0, 66.0, 68.0, 67.0, 72.0, 67.0, 68.0], "value": 66.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 63.0, 62.0, 68.0, 65.0, 60.0, 78.0, 85.0, 56.0, 59.0], "value": 65.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 85.0, 91.0, 107.0, 80.0, 85.0, 83.0, 81.0, 86.0, 81.0], "value": 86.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 151.0, 136.0, 154.0, 140.0, 116.0, 144.0, 164.0, 207.0, 168.0], "value": 154.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 166.0, 181.0, 164.0, 166.0, 163.0, 164.0, 166.0, 162.0, 164.0], "value": 166.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 71.0, 82.0, 87.0, 83.0, 76.0, 65.0, 63.0, 64.0, 65.0], "value": 72.3, "unit": "score"}]}]} 14:47:44 INFO - Return code: 0 14:47:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:47:44 ERROR - # TBPL SUCCESS # 14:47:44 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:47:44 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:47:44 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:47:44 INFO - 2017-05-01 14:47:44.180 screenresolution[1657:10543] starting screenresolution argv=screenresolution get 14:47:44 INFO - 2017-05-01 14:47:44.182 screenresolution[1657:10543] Display 0: 1600x1200x32@60 14:47:44 INFO - 2017-05-01 14:47:44.188 screenresolution[1658:10546] starting screenresolution argv=screenresolution list 14:47:44 INFO - Available Modes on Display 0 14:47:44 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:47:44 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:47:44 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:47:44 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:47:44 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:47:44 INFO - Intel Iris: 14:47:44 INFO - Chipset Model: Intel Iris 14:47:44 INFO - Type: GPU 14:47:44 INFO - Bus: Built-In 14:47:44 INFO - VRAM (Dynamic, Max): 1536 MB 14:47:44 INFO - Vendor: Intel (0x8086) 14:47:44 INFO - Device ID: 0x0a2e 14:47:44 INFO - Revision ID: 0x0009 14:47:44 INFO - Displays: 14:47:44 INFO - Display: 14:47:44 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:47:44 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:47:44 INFO - Display Serial Number: 1600x1200 60 14:47:44 INFO - Main Display: Yes 14:47:44 INFO - Mirror: Off 14:47:44 INFO - Online: Yes 14:47:44 INFO - Rotation: Supported 14:47:44 INFO - Return code: 0 14:47:44 INFO - Running post-action listener: _resource_record_post_action 14:47:44 INFO - [mozharness: 2017-05-01 21:47:44.424672Z] Finished run-tests step (success) 14:47:44 INFO - Running post-run listener: _resource_record_post_run 14:47:44 INFO - Total resource usage - Wall time: 1193s; CPU: 55.0%; Read bytes: 40851456; Write bytes: 424606720; Read time: 396; Write time: 1524 14:47:44 INFO - TinderboxPrint: CPU usage
54.7% 14:47:44 INFO - TinderboxPrint: I/O read bytes / time
40,851,456 / 396 14:47:44 INFO - TinderboxPrint: I/O write bytes / time
424,606,720 / 1,524 14:47:44 INFO - TinderboxPrint: CPU idle
2,164.4 (45.3%) 14:47:44 INFO - TinderboxPrint: CPU system
961.7 (20.1%) 14:47:44 INFO - TinderboxPrint: CPU user
1,647.6 (34.5%) 14:47:44 INFO - TinderboxPrint: Swap in / out
162,783,232 / 0 14:47:44 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 123099648; Write bytes: 124438528; Read time: 11062; Write time: 297 14:47:44 INFO - run-tests - Wall time: 1179s; CPU: 55.0%; Read bytes: 35784704; Write bytes: 298763264; Read time: 361; Write time: 1223 14:47:44 INFO - Running post-run listener: _upload_blobber_files 14:47:44 INFO - Blob upload gear active. 14:47:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:47:44 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 14:47:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:47:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:47:45 INFO - (blobuploader) - INFO - Open directory for files ... 14:47:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:47:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:47:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:47:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:47:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:47:46 INFO - (blobuploader) - INFO - Done attempting. 14:47:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:47:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:47:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:47:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:47:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:47:47 INFO - (blobuploader) - INFO - Done attempting. 14:47:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 14:47:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:47:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:47:48 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 14:47:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:47:48 INFO - (blobuploader) - INFO - Done attempting. 14:47:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:47:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:47:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:47:50 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:47:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:47:50 INFO - (blobuploader) - INFO - Done attempting. 14:47:50 INFO - (blobuploader) - INFO - Iteration through files over. 14:47:50 INFO - Return code: 0 14:47:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:47:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:47:50 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e52af32cedde27bb530a143a256d39cce565a6f9acb25d11b1f5f676300b863305a0cc40458c830eac1e5d7dae21144af2936199193446fc9e2eeab0f35ad9a1", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e2a51ef5c2a5162366d7858078ef36f690a137fb12debf379205a7b44883a921e9510829e62aa61a16cf1c8f76134a227c278405a16052d26b41cb956fea041f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cb50507e2a7ecb7ff832548fd6a15db132f54fc68b640eeea0d530d21f3086fc5bd6f26864f0815c8da7b8f336081af40db455446a65860688877fa31730d29f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/165f0d3dd0b6b621687c40b1c3e2176622ad550fd523a241d91f9e5e520fcbfd516ce53d1ad62bd465b8ce36be7048349b94a4403d7fe617a48cfce822f371c2"} 14:47:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:47:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:47:50 INFO - Contents: 14:47:50 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e52af32cedde27bb530a143a256d39cce565a6f9acb25d11b1f5f676300b863305a0cc40458c830eac1e5d7dae21144af2936199193446fc9e2eeab0f35ad9a1", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e2a51ef5c2a5162366d7858078ef36f690a137fb12debf379205a7b44883a921e9510829e62aa61a16cf1c8f76134a227c278405a16052d26b41cb956fea041f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cb50507e2a7ecb7ff832548fd6a15db132f54fc68b640eeea0d530d21f3086fc5bd6f26864f0815c8da7b8f336081af40db455446a65860688877fa31730d29f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/165f0d3dd0b6b621687c40b1c3e2176622ad550fd523a241d91f9e5e520fcbfd516ce53d1ad62bd465b8ce36be7048349b94a4403d7fe617a48cfce822f371c2"} 14:47:50 INFO - Running post-run listener: copy_logs_to_upload_dir 14:47:50 INFO - Copying logs to upload dir... 14:47:50 INFO - mkdir: /builds/slave/test/build/upload/logs 14:47:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1276.515173 ========= master_lag: 0.69 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2017-05-01 14:47:51.459013) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-01 14:47:51.464813) ========= 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.QlGMfDEdKm/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.cTHoA5vUlU/Listeners TMPDIR=/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e52af32cedde27bb530a143a256d39cce565a6f9acb25d11b1f5f676300b863305a0cc40458c830eac1e5d7dae21144af2936199193446fc9e2eeab0f35ad9a1", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e2a51ef5c2a5162366d7858078ef36f690a137fb12debf379205a7b44883a921e9510829e62aa61a16cf1c8f76134a227c278405a16052d26b41cb956fea041f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cb50507e2a7ecb7ff832548fd6a15db132f54fc68b640eeea0d530d21f3086fc5bd6f26864f0815c8da7b8f336081af40db455446a65860688877fa31730d29f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/165f0d3dd0b6b621687c40b1c3e2176622ad550fd523a241d91f9e5e520fcbfd516ce53d1ad62bd465b8ce36be7048349b94a4403d7fe617a48cfce822f371c2"} build_url:https://queue.taskcluster.net/v1/task/V1GB8lRYRWO1M3x2Ap3wCQ/artifacts/public/build/firefox-54.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010886 build_url: 'https://queue.taskcluster.net/v1/task/V1GB8lRYRWO1M3x2Ap3wCQ/artifacts/public/build/firefox-54.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e52af32cedde27bb530a143a256d39cce565a6f9acb25d11b1f5f676300b863305a0cc40458c830eac1e5d7dae21144af2936199193446fc9e2eeab0f35ad9a1", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e2a51ef5c2a5162366d7858078ef36f690a137fb12debf379205a7b44883a921e9510829e62aa61a16cf1c8f76134a227c278405a16052d26b41cb956fea041f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cb50507e2a7ecb7ff832548fd6a15db132f54fc68b640eeea0d530d21f3086fc5bd6f26864f0815c8da7b8f336081af40db455446a65860688877fa31730d29f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/165f0d3dd0b6b621687c40b1c3e2176622ad550fd523a241d91f9e5e520fcbfd516ce53d1ad62bd465b8ce36be7048349b94a4403d7fe617a48cfce822f371c2"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-01 14:47:51.499986) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-01 14:47:51.500300) ========= 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.QlGMfDEdKm/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.cTHoA5vUlU/Listeners TMPDIR=/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/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.005164 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-01 14:47:51.548953) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-01 14:47:51.549379) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-01 14:47:51.549914) ========= ========= Total master_lag: 0.83 =========