builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0314 starttime: 1484858856.94 results: success (0) buildid: 20170119071129 builduid: c70f3fdf1f924acab3275675a44e0caf revision: a3978751f45108ff1ae002ecebdc0fa23fc52b84 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-19 12:47:36.944919) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-19 12:47:36.945448) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-19 12:47:36.945856) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-19 12:47:37.009278) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-19 12:47:37.009592) ========= 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.jPzWAUIsxF/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.F7XSBgcGmV/Listeners TMPDIR=/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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-01-19 12:47:37-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 13.6M=0.001s 2017-01-19 12:47:37 (13.6 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.474055 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-19 12:47:37.514059) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-19 12:47:37.514380) ========= 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.jPzWAUIsxF/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.F7XSBgcGmV/Listeners TMPDIR=/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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.020497 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-19 12:47:37.564841) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-19 12:47:37.565215) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev a3978751f45108ff1ae002ecebdc0fa23fc52b84 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev a3978751f45108ff1ae002ecebdc0fa23fc52b84 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.jPzWAUIsxF/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.F7XSBgcGmV/Listeners TMPDIR=/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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-01-19 12:47:37,662 truncating revision to first 12 chars 2017-01-19 12:47:37,662 Setting DEBUG logging. 2017-01-19 12:47:37,662 attempt 1/10 2017-01-19 12:47:37,662 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/a3978751f451?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-19 12:47:38,759 unpacking tar archive at: mozilla-central-a3978751f451/testing/mozharness/ program finished with exit code 0 elapsedTime=1.346288 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-19 12:47:38.936077) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-19 12:47:38.936454) ========= script_repo_revision: a3978751f45108ff1ae002ecebdc0fa23fc52b84 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-19 12:47:38.936930) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-19 12:47:38.937249) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-19 12:47:38.959324) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2017-01-19 12:47:38.959769) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.jPzWAUIsxF/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.F7XSBgcGmV/Listeners TMPDIR=/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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 12:47:39 INFO - MultiFileLogger online at 20170119 12:47:39 in /builds/slave/test 12:47:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 12:47:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:47:39 INFO - {'append_to_log': False, 12:47:39 INFO - 'base_work_dir': '/builds/slave/test', 12:47:39 INFO - 'blob_upload_branch': 'Firefox', 12:47:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:47:39 INFO - 'branch': 'Firefox', 12:47:39 INFO - 'buildbot_json_path': 'buildprops.json', 12:47:39 INFO - 'config_files': ('talos/mac_config.py',), 12:47:39 INFO - 'default_actions': ('clobber', 12:47:39 INFO - 'read-buildbot-config', 12:47:39 INFO - 'download-and-extract', 12:47:39 INFO - 'populate-webroot', 12:47:39 INFO - 'create-virtualenv', 12:47:39 INFO - 'install', 12:47:39 INFO - 'run-tests'), 12:47:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:47:39 INFO - 'download_minidump_stackwalk': True, 12:47:39 INFO - 'download_symbols': 'ondemand', 12:47:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:47:39 INFO - 'tooltool.py': '/tools/tooltool.py', 12:47:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:47:39 INFO - '/tools/misc-python/virtualenv.py')}, 12:47:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:47:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:47:39 INFO - 'installer_path': 'installer.exe', 12:47:39 INFO - 'log_level': 'info', 12:47:39 INFO - 'log_name': 'talos', 12:47:39 INFO - 'log_to_console': True, 12:47:39 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 12:47:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 12:47:39 INFO - 'opt_config_files': (), 12:47:39 INFO - 'pip_index': False, 12:47:39 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:47:39 INFO - 'cmd': ('bash', 12:47:39 INFO - '-c', 12:47:39 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:47:39 INFO - 'enabled': True, 12:47:39 INFO - 'halt_on_failure': False, 12:47:39 INFO - 'name': 'check_screen_resolution'},), 12:47:39 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:47:39 INFO - 'cmd': ('bash', 12:47:39 INFO - '-c', 12:47:39 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:47:39 INFO - 'enabled': True, 12:47:39 INFO - 'halt_on_failure': False, 12:47:39 INFO - 'name': 'check_screen_resolution'},), 12:47:39 INFO - 'run_cmd_checks_enabled': True, 12:47:39 INFO - 'sps_profile': False, 12:47:39 INFO - 'sps_profile_interval': 0, 12:47:39 INFO - 'suite': 'dromaeojs-e10s', 12:47:39 INFO - 'system_bits': '32', 12:47:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:47:39 INFO - 'title': 't-yosemite-r7-0314', 12:47:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:47:39 INFO - 'use_talos_json': True, 12:47:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:47:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:47:39 INFO - 'work_dir': 'build'} 12:47:39 INFO - [mozharness: 2017-01-19 20:47:39.179970Z] Running clobber step. 12:47:39 INFO - Running pre-action listener: _resource_record_pre_action 12:47:39 INFO - Running main action method: clobber 12:47:39 INFO - rmtree: /builds/slave/test/build 12:47:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:47:41 INFO - Running post-action listener: _resource_record_post_action 12:47:41 INFO - [mozharness: 2017-01-19 20:47:41.362840Z] Finished clobber step (success) 12:47:41 INFO - [mozharness: 2017-01-19 20:47:41.363030Z] Running read-buildbot-config step. 12:47:41 INFO - Running pre-action listener: _resource_record_pre_action 12:47:41 INFO - Running main action method: read_buildbot_config 12:47:41 INFO - Using buildbot properties: 12:47:41 INFO - { 12:47:41 INFO - "project": "", 12:47:41 INFO - "product": "firefox", 12:47:41 INFO - "script_repo_revision": "production", 12:47:41 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 12:47:41 INFO - "repository": "", 12:47:41 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 12:47:41 INFO - "buildid": "20170119071129", 12:47:41 INFO - "pgo_build": "False", 12:47:41 INFO - "basedir": "/builds/slave/test", 12:47:41 INFO - "buildnumber": 64, 12:47:41 INFO - "slavename": "t-yosemite-r7-0314", 12:47:41 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 12:47:41 INFO - "platform": "yosemite_r7", 12:47:41 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 12:47:41 INFO - "branch": "mozilla-central", 12:47:41 INFO - "repo_path": "mozilla-central", 12:47:41 INFO - "revision": "a3978751f45108ff1ae002ecebdc0fa23fc52b84", 12:47:41 INFO - "stage_platform": "macosx64", 12:47:41 INFO - "builduid": "c70f3fdf1f924acab3275675a44e0caf", 12:47:41 INFO - "slavebuilddir": "test" 12:47:41 INFO - } 12:47:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/I5vM5wREQx6CvNpKF5tLdg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 12:47:41 INFO - Running post-action listener: _resource_record_post_action 12:47:41 INFO - [mozharness: 2017-01-19 20:47:41.366380Z] Finished read-buildbot-config step (success) 12:47:41 INFO - [mozharness: 2017-01-19 20:47:41.366469Z] Running download-and-extract step. 12:47:41 INFO - Running pre-action listener: _resource_record_pre_action 12:47:41 INFO - Running main action method: download_and_extract 12:47:41 INFO - mkdir: /builds/slave/test/build/tests 12:47:41 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')]} 12:47:41 INFO - trying https://queue.taskcluster.net/v1/task/I5vM5wREQx6CvNpKF5tLdg/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 12:47:41 INFO - Downloading https://queue.taskcluster.net/v1/task/I5vM5wREQx6CvNpKF5tLdg/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 12:47:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/I5vM5wREQx6CvNpKF5tLdg/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 12:47:43 INFO - Downloaded 1199 bytes. 12:47:43 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 12:47:43 INFO - Using the following test package requirements: 12:47:43 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 12:47:43 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 12:47:43 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 12:47:43 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 12:47:43 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 12:47:43 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 12:47:43 INFO - u'jsshell-mac.zip'], 12:47:43 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 12:47:43 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 12:47:43 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 12:47:43 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 12:47:43 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 12:47:43 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 12:47:43 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 12:47:43 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 12:47:43 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 12:47:43 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 12:47:43 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 12:47:43 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 12:47:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/I5vM5wREQx6CvNpKF5tLdg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 12:47:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/I5vM5wREQx6CvNpKF5tLdg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 12:47:43 INFO - Fetch https://queue.taskcluster.net/v1/task/I5vM5wREQx6CvNpKF5tLdg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 12:47:44 INFO - Expected file size: 16340629 12:47:44 INFO - Obtained file size: 16340629 12:47:51 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 12:47:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/I5vM5wREQx6CvNpKF5tLdg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 12:47:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/I5vM5wREQx6CvNpKF5tLdg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 12:47:51 INFO - Fetch https://queue.taskcluster.net/v1/task/I5vM5wREQx6CvNpKF5tLdg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 12:47:53 INFO - Expected file size: 16340629 12:47:53 INFO - Obtained file size: 16340629 12:47:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/I5vM5wREQx6CvNpKF5tLdg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 12:47:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/I5vM5wREQx6CvNpKF5tLdg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 12:47:59 INFO - Fetch https://queue.taskcluster.net/v1/task/I5vM5wREQx6CvNpKF5tLdg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 12:48:01 INFO - Expected file size: 14403463 12:48:01 INFO - Obtained file size: 14403463 12:48:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:48:01 INFO - trying https://queue.taskcluster.net/v1/task/I5vM5wREQx6CvNpKF5tLdg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 12:48:01 INFO - Downloading https://queue.taskcluster.net/v1/task/I5vM5wREQx6CvNpKF5tLdg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 12:48:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/I5vM5wREQx6CvNpKF5tLdg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 12:48:05 INFO - Downloaded 69915509 bytes. 12:48:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/I5vM5wREQx6CvNpKF5tLdg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 12:48:05 INFO - mkdir: /builds/slave/test/properties 12:48:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:48:05 INFO - Writing to file /builds/slave/test/properties/build_url 12:48:05 INFO - Contents: 12:48:05 INFO - build_url:https://queue.taskcluster.net/v1/task/I5vM5wREQx6CvNpKF5tLdg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 12:48:06 INFO - Running post-action listener: _resource_record_post_action 12:48:06 INFO - Running post-action listener: set_extra_try_arguments 12:48:06 INFO - [mozharness: 2017-01-19 20:48:06.040207Z] Finished download-and-extract step (success) 12:48:06 INFO - [mozharness: 2017-01-19 20:48:06.040381Z] Running populate-webroot step. 12:48:06 INFO - Running pre-action listener: _resource_record_pre_action 12:48:06 INFO - Running main action method: populate_webroot 12:48:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:48:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:48:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:48:06 INFO - '--tppagecycles', 12:48:06 INFO - '7'], 12:48:06 INFO - 'tests': ['tsvgm']}}, 12:48:06 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:48:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:48:06 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:48:06 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:48:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:48:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:48:06 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 12:48:06 INFO - 'talos_options': ['--disable-e10s'], 12:48:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:48:06 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 12:48:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:48:06 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 12:48:06 INFO - 'talos_options': ['--disable-e10s'], 12:48:06 INFO - 'tests': ['damp', 'tps']}, 12:48:06 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 12:48:06 INFO - 'tests': ['damp', 'tps']}, 12:48:06 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:48:06 INFO - 'tests': ['dromaeo_dom']}, 12:48:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:48:06 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:48:06 INFO - 'tests': ['basic_compositor_video']}, 12:48:06 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:48:06 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:48:06 INFO - 'tests': ['a11yr', 12:48:06 INFO - 'ts_paint', 12:48:06 INFO - 'tpaint', 12:48:06 INFO - 'sessionrestore', 12:48:06 INFO - 'sessionrestore_no_auto_restore', 12:48:06 INFO - 'tabpaint']}, 12:48:06 INFO - 'other-e10s': {'tests': ['a11yr', 12:48:06 INFO - 'ts_paint', 12:48:06 INFO - 'tpaint', 12:48:06 INFO - 'sessionrestore', 12:48:06 INFO - 'sessionrestore_no_auto_restore', 12:48:06 INFO - 'tabpaint']}, 12:48:06 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:48:06 INFO - 'ts_paint', 12:48:06 INFO - 'tpaint', 12:48:06 INFO - 'sessionrestore', 12:48:06 INFO - 'sessionrestore_no_auto_restore', 12:48:06 INFO - 'tabpaint']}, 12:48:06 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:48:06 INFO - 'ts_paint', 12:48:06 INFO - 'tpaint', 12:48:06 INFO - 'sessionrestore', 12:48:06 INFO - 'sessionrestore_no_auto_restore', 12:48:06 INFO - 'tabpaint']}, 12:48:06 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:48:06 INFO - 'tests': ['a11yr', 12:48:06 INFO - 'ts_paint', 12:48:06 INFO - 'tpaint', 12:48:06 INFO - 'sessionrestore', 12:48:06 INFO - 'sessionrestore_no_auto_restore', 12:48:06 INFO - 'tabpaint']}, 12:48:06 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:48:06 INFO - 'tests': ['a11yr', 12:48:06 INFO - 'ts_paint', 12:48:06 INFO - 'tpaint', 12:48:06 INFO - 'sessionrestore', 12:48:06 INFO - 'sessionrestore_no_auto_restore', 12:48:06 INFO - 'tabpaint']}, 12:48:06 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:48:06 INFO - 'tests': ['tsvgx', 12:48:06 INFO - 'tsvgr_opacity', 12:48:06 INFO - 'tart', 12:48:06 INFO - 'tscrollx', 12:48:06 INFO - 'cart', 12:48:06 INFO - 'tsvg_static']}, 12:48:06 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:48:06 INFO - 'tsvgr_opacity', 12:48:06 INFO - 'tart', 12:48:06 INFO - 'tscrollx', 12:48:06 INFO - 'cart', 12:48:06 INFO - 'tsvg_static']}, 12:48:06 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 12:48:06 INFO - 'talos_options': ['--disable-e10s'], 12:48:06 INFO - 'tests': ['tp5o']}, 12:48:06 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 12:48:06 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 12:48:06 INFO - 'talos_options': ['--disable-e10s', 12:48:06 INFO - '--xperf_path', 12:48:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:48:06 INFO - 'tests': ['tp5n']}, 12:48:06 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 12:48:06 INFO - 'talos_options': ['--xperf_path', 12:48:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:48:06 INFO - 'tests': ['tp5n']}}, 12:48:06 INFO - 'talos.zip': {'path': '', 12:48:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:48:06 INFO - Running post-action listener: _resource_record_post_action 12:48:06 INFO - [mozharness: 2017-01-19 20:48:06.058791Z] Finished populate-webroot step (success) 12:48:06 INFO - [mozharness: 2017-01-19 20:48:06.058925Z] Running create-virtualenv step. 12:48:06 INFO - Running pre-action listener: _resource_record_pre_action 12:48:06 INFO - Running main action method: create_virtualenv 12:48:06 INFO - Creating virtualenv /builds/slave/test/build/venv 12:48:06 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 12:48:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:48:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:48:06 INFO - Using real prefix '/tools/python27' 12:48:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:48:06 INFO - Installing distribute.............................................................................................................................................................................................done. 12:48:09 INFO - Installing pip.................done. 12:48:09 INFO - Return code: 0 12:48:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:48:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:48:10 INFO - Reading from file tmpfile_stdout 12:48:10 INFO - Output received: 12:48:10 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) 12:48:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:48:10 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')]} 12:48:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:48:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:10 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')]} 12:48:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:48:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:10 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 0x10e40eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e411768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81434d2210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e1ecd30>, '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 0x10e113db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e1e1be8>, '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.jPzWAUIsxF/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.F7XSBgcGmV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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 12:48:10 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 12:48:10 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 12:48:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jPzWAUIsxF/Render', 12:48:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:48:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:48:10 INFO - 'HOME': '/Users/cltbld', 12:48:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:48:10 INFO - 'LOGNAME': 'cltbld', 12:48:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:48:10 INFO - 'MOZ_NO_REMOTE': '1', 12:48:10 INFO - 'NO_EM_RESTART': '1', 12:48:10 INFO - 'PAGER': '/bin/cat', 12:48:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:48:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:48:10 INFO - 'PWD': '/builds/slave/test', 12:48:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:48:10 INFO - 'SHELL': '/bin/bash', 12:48:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.F7XSBgcGmV/Listeners', 12:48:10 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 12:48:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:48:10 INFO - 'USER': 'cltbld', 12:48:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:48:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:48:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:48:10 INFO - 'XPC_FLAGS': '0x0', 12:48:10 INFO - 'XPC_SERVICE_NAME': '0', 12:48:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:48:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:48:10 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 12:48:10 INFO - Cleaning up... 12:48:10 INFO - Return code: 0 12:48:10 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:48:10 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')]} 12:48:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:48:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:10 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')]} 12:48:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:48:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:10 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 0x10e40eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e411768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81434d2210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e1ecd30>, '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 0x10e113db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e1e1be8>, '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.jPzWAUIsxF/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.F7XSBgcGmV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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 12:48:10 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 12:48:10 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 12:48:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jPzWAUIsxF/Render', 12:48:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:48:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:48:10 INFO - 'HOME': '/Users/cltbld', 12:48:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:48:10 INFO - 'LOGNAME': 'cltbld', 12:48:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:48:10 INFO - 'MOZ_NO_REMOTE': '1', 12:48:10 INFO - 'NO_EM_RESTART': '1', 12:48:10 INFO - 'PAGER': '/bin/cat', 12:48:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:48:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:48:10 INFO - 'PWD': '/builds/slave/test', 12:48:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:48:10 INFO - 'SHELL': '/bin/bash', 12:48:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.F7XSBgcGmV/Listeners', 12:48:10 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 12:48:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:48:10 INFO - 'USER': 'cltbld', 12:48:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:48:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:48:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:48:10 INFO - 'XPC_FLAGS': '0x0', 12:48:10 INFO - 'XPC_SERVICE_NAME': '0', 12:48:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:48:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:48:10 INFO - Downloading/unpacking psutil>=3.1.1 12:48:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:48:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:48:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:48:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:48:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:48:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:48:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:48:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:48:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:48:14 INFO - Installing collected packages: psutil 12:48:14 INFO - Running setup.py install for psutil 12:48:14 INFO - building 'psutil._psutil_osx' extension 12:48:14 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 12:48:14 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 12:48:14 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 12:48:15 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 12:48:15 INFO - building 'psutil._psutil_posix' extension 12:48:15 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 12:48:15 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 12:48:15 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 12:48:15 INFO - ^ 12:48:15 INFO - 1 warning generated. 12:48:15 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 12:48:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:48:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:48:15 INFO - Successfully installed psutil 12:48:15 INFO - Cleaning up... 12:48:15 INFO - Return code: 0 12:48:15 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:48:15 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')]} 12:48:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:48:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:15 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')]} 12:48:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:48:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:15 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 0x10e40eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e411768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81434d2210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e1ecd30>, '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 0x10e113db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e1e1be8>, '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.jPzWAUIsxF/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.F7XSBgcGmV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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 12:48:15 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 12:48:15 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 12:48:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jPzWAUIsxF/Render', 12:48:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:48:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:48:15 INFO - 'HOME': '/Users/cltbld', 12:48:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:48:15 INFO - 'LOGNAME': 'cltbld', 12:48:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:48:15 INFO - 'MOZ_NO_REMOTE': '1', 12:48:15 INFO - 'NO_EM_RESTART': '1', 12:48:15 INFO - 'PAGER': '/bin/cat', 12:48:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:48:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:48:15 INFO - 'PWD': '/builds/slave/test', 12:48:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:48:15 INFO - 'SHELL': '/bin/bash', 12:48:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.F7XSBgcGmV/Listeners', 12:48:15 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 12:48:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:48:15 INFO - 'USER': 'cltbld', 12:48:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:48:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:48:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:48:15 INFO - 'XPC_FLAGS': '0x0', 12:48:15 INFO - 'XPC_SERVICE_NAME': '0', 12:48:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:48:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:48:15 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:48:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:48:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:48:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:48:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:48:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:48:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:48:18 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:48:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:48:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:48:18 INFO - Installing collected packages: mozsystemmonitor 12:48:18 INFO - Running setup.py install for mozsystemmonitor 12:48:18 INFO - Successfully installed mozsystemmonitor 12:48:18 INFO - Cleaning up... 12:48:18 INFO - Return code: 0 12:48:18 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:48:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:48:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:48:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:48:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:48:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:18 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 0x10e40eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e411768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81434d2210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e1ecd30>, '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 0x10e113db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e1e1be8>, '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.jPzWAUIsxF/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.F7XSBgcGmV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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 12:48:18 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 12:48:18 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 12:48:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jPzWAUIsxF/Render', 12:48:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:48:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:48:18 INFO - 'HOME': '/Users/cltbld', 12:48:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:48:18 INFO - 'LOGNAME': 'cltbld', 12:48:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:48:18 INFO - 'MOZ_NO_REMOTE': '1', 12:48:18 INFO - 'NO_EM_RESTART': '1', 12:48:18 INFO - 'PAGER': '/bin/cat', 12:48:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:48:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:48:18 INFO - 'PWD': '/builds/slave/test', 12:48:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:48:18 INFO - 'SHELL': '/bin/bash', 12:48:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.F7XSBgcGmV/Listeners', 12:48:18 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 12:48:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:48:18 INFO - 'USER': 'cltbld', 12:48:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:48:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:48:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:48:18 INFO - 'XPC_FLAGS': '0x0', 12:48:18 INFO - 'XPC_SERVICE_NAME': '0', 12:48:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:48:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:48:18 INFO - Downloading/unpacking jsonschema==2.5.1 12:48:18 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 12:48:18 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 12:48:18 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 12:48:18 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 12:48:18 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 12:48:18 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 12:48:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:48:21 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:48: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 12:48: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 12:48: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 12:48: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 12:48: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 12:48: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 12:48:21 INFO - Downloading functools32-3.2.3-2.tar.gz 12:48:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:48:21 INFO - warning: no files found matching '*.txt' 12:48:21 INFO - no previously-included directories found matching 'build' 12:48:21 INFO - no previously-included directories found matching 'dist' 12:48:21 INFO - no previously-included directories found matching '.git*' 12:48:21 INFO - Installing collected packages: jsonschema, functools32 12:48:22 INFO - Running setup.py install for functools32 12:48:22 INFO - warning: no files found matching '*.txt' 12:48:22 INFO - no previously-included directories found matching 'build' 12:48:22 INFO - no previously-included directories found matching 'dist' 12:48:22 INFO - no previously-included directories found matching '.git*' 12:48:22 INFO - Successfully installed jsonschema functools32 12:48:22 INFO - Cleaning up... 12:48:22 INFO - Return code: 0 12:48:22 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:48:22 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')]} 12:48:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:48:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:22 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')]} 12:48:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:48:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:22 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 0x10e40eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e411768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81434d2210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e1ecd30>, '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 0x10e113db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e1e1be8>, '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.jPzWAUIsxF/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.F7XSBgcGmV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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 12:48:22 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 12:48:22 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 12:48:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jPzWAUIsxF/Render', 12:48:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:48:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:48:22 INFO - 'HOME': '/Users/cltbld', 12:48:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:48:22 INFO - 'LOGNAME': 'cltbld', 12:48:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:48:22 INFO - 'MOZ_NO_REMOTE': '1', 12:48:22 INFO - 'NO_EM_RESTART': '1', 12:48:22 INFO - 'PAGER': '/bin/cat', 12:48:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:48:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:48:22 INFO - 'PWD': '/builds/slave/test', 12:48:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:48:22 INFO - 'SHELL': '/bin/bash', 12:48:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.F7XSBgcGmV/Listeners', 12:48:22 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 12:48:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:48:22 INFO - 'USER': 'cltbld', 12:48:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:48:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:48:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:48:22 INFO - 'XPC_FLAGS': '0x0', 12:48:22 INFO - 'XPC_SERVICE_NAME': '0', 12:48:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:48:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:48:22 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:48:22 INFO - Cleaning up... 12:48:22 INFO - Return code: 0 12:48:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:48:22 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')]} 12:48:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:48:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:22 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')]} 12:48:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:48:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:22 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 0x10e40eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e411768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81434d2210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e1ecd30>, '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 0x10e113db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e1e1be8>, '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.jPzWAUIsxF/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.F7XSBgcGmV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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 12:48:22 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 12:48:22 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 12:48:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jPzWAUIsxF/Render', 12:48:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:48:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:48:22 INFO - 'HOME': '/Users/cltbld', 12:48:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:48:22 INFO - 'LOGNAME': 'cltbld', 12:48:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:48:22 INFO - 'MOZ_NO_REMOTE': '1', 12:48:22 INFO - 'NO_EM_RESTART': '1', 12:48:22 INFO - 'PAGER': '/bin/cat', 12:48:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:48:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:48:22 INFO - 'PWD': '/builds/slave/test', 12:48:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:48:22 INFO - 'SHELL': '/bin/bash', 12:48:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.F7XSBgcGmV/Listeners', 12:48:22 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 12:48:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:48:22 INFO - 'USER': 'cltbld', 12:48:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:48:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:48:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:48:22 INFO - 'XPC_FLAGS': '0x0', 12:48:22 INFO - 'XPC_SERVICE_NAME': '0', 12:48:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:48:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:48:22 INFO - Downloading/unpacking blobuploader==1.2.4 12:48:22 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 12:48:22 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 12:48:22 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 12:48:22 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 12:48:22 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 12:48:22 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 12:48:25 INFO - Downloading blobuploader-1.2.4.tar.gz 12:48:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:48:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:48:25 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 12:48:25 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 12:48:25 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 12:48:25 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 12:48:25 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 12:48:25 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 12:48:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:48:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:48:26 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 12:48:26 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 12:48:26 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 12:48:26 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 12:48:26 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 12:48:26 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 12:48:26 INFO - Downloading docopt-0.6.1.tar.gz 12:48:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:48:26 INFO - Installing collected packages: blobuploader, requests, docopt 12:48:26 INFO - Running setup.py install for blobuploader 12:48:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:48:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:48:26 INFO - Running setup.py install for requests 12:48:27 INFO - Running setup.py install for docopt 12:48:27 INFO - Successfully installed blobuploader requests docopt 12:48:27 INFO - Cleaning up... 12:48:27 INFO - Return code: 0 12:48:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:48: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')]} 12:48:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:48:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48: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')]} 12:48:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:48:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:27 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 0x10e40eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e411768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81434d2210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e1ecd30>, '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 0x10e113db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e1e1be8>, '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.jPzWAUIsxF/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.F7XSBgcGmV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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 12:48:27 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 12:48:27 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 12:48:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jPzWAUIsxF/Render', 12:48:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:48:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:48:27 INFO - 'HOME': '/Users/cltbld', 12:48:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:48:27 INFO - 'LOGNAME': 'cltbld', 12:48:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:48:27 INFO - 'MOZ_NO_REMOTE': '1', 12:48:27 INFO - 'NO_EM_RESTART': '1', 12:48:27 INFO - 'PAGER': '/bin/cat', 12:48:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:48:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:48:27 INFO - 'PWD': '/builds/slave/test', 12:48:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:48:27 INFO - 'SHELL': '/bin/bash', 12:48:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.F7XSBgcGmV/Listeners', 12:48:27 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 12:48:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:48:27 INFO - 'USER': 'cltbld', 12:48:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:48:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:48:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:48:27 INFO - 'XPC_FLAGS': '0x0', 12:48:27 INFO - 'XPC_SERVICE_NAME': '0', 12:48:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:48:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:48:27 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-tmkd0z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:48:27 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-xIMO_Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:48:28 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-FbENyx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:48:28 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-WTBpb7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:48:28 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-gAuGzC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:48:28 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-H5gUNl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:48:28 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-65Bm5M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:48:28 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-haabl0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:48:28 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-1r6cuT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:48:28 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-s8nZb5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:48:28 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-3P7zyB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:48:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:48:29 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-cA4qDD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:48:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:48:29 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-t12MTU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:48:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:48:29 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-Pob5hz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:48:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:48:29 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-VUmHsu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:48:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:48:29 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-0gyuKy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:48:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:48:29 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-Onqxrc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:48:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:48:29 INFO - Running setup.py install for manifestparser 12:48:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:48:29 INFO - Running setup.py install for mozcrash 12:48:29 INFO - Running setup.py install for mozdebug 12:48:30 INFO - Running setup.py install for mozdevice 12:48:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:48:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:48:30 INFO - Running setup.py install for mozfile 12:48:30 INFO - Running setup.py install for mozhttpd 12:48:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:48:30 INFO - Running setup.py install for mozinfo 12:48:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:48:30 INFO - Running setup.py install for mozInstall 12:48:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:48:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:48:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:48:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:48:30 INFO - Running setup.py install for mozleak 12:48:30 INFO - Running setup.py install for mozlog 12:48:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:48:31 INFO - Running setup.py install for moznetwork 12:48:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:48:31 INFO - Running setup.py install for mozprocess 12:48:31 INFO - Running setup.py install for mozprofile 12:48:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:48:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:48:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:48:31 INFO - Running setup.py install for mozrunner 12:48:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:48:31 INFO - Running setup.py install for mozscreenshot 12:48:31 INFO - Running setup.py install for moztest 12:48:32 INFO - Running setup.py install for mozversion 12:48:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:48:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:48:32 INFO - Cleaning up... 12:48:32 INFO - Return code: 0 12:48:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:48:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:48:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:48:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:48:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:48:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:32 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 0x10e40eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e411768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81434d2210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e1ecd30>, '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 0x10e113db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e1e1be8>, '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.jPzWAUIsxF/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.F7XSBgcGmV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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 12:48:32 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 12:48:32 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 12:48:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jPzWAUIsxF/Render', 12:48:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:48:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:48:32 INFO - 'HOME': '/Users/cltbld', 12:48:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:48:32 INFO - 'LOGNAME': 'cltbld', 12:48:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:48:32 INFO - 'MOZ_NO_REMOTE': '1', 12:48:32 INFO - 'NO_EM_RESTART': '1', 12:48:32 INFO - 'PAGER': '/bin/cat', 12:48:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:48:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:48:32 INFO - 'PWD': '/builds/slave/test', 12:48:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:48:32 INFO - 'SHELL': '/bin/bash', 12:48:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.F7XSBgcGmV/Listeners', 12:48:32 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 12:48:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:48:32 INFO - 'USER': 'cltbld', 12:48:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:48:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:48:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:48:32 INFO - 'XPC_FLAGS': '0x0', 12:48:32 INFO - 'XPC_SERVICE_NAME': '0', 12:48:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:48:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:48:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:48:32 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-8XWkPP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:48:32 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)) 12:48:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:48:32 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-9Xg_d7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:48:32 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)) 12:48:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:48:32 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-RmIqCp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:48:32 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)) 12:48:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:48:32 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-PtsuCV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:48:32 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)) 12:48:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:48:32 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-J45scL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:48:33 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)) 12:48:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:48:33 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-ktf3mQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:48:33 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)) 12:48:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:48:33 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-qLeqN6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:48:33 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)) 12:48:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:48:33 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-5EbfRs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:48:33 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)) 12:48:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:48:33 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-QIcCeQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:48:33 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)) 12:48:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:48:33 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-bvzV2h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:48:33 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)) 12:48:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:48:33 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-VmClc_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:48:33 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)) 12:48:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:48:33 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-ZBznYZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:48:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 12:48:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:48:33 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-h1GCCx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:48:33 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)) 12:48:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:48:33 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-Uiwga4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:48:33 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)) 12:48:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:48:33 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-ebO5wP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:48:34 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)) 12:48:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:48:34 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-8lIKSd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:48:34 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)) 12:48:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:48:34 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-o7oKaI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:48:34 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)) 12:48:34 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)) 12:48:34 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)) 12:48:34 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)) 12:48:34 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)) 12:48:34 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)) 12:48:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:48: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 12:48: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 12:48: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 12:48: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 12:48: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 12:48: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 12:48:37 INFO - Downloading blessings-1.6.tar.gz 12:48:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:48:37 INFO - Installing collected packages: blessings 12:48:37 INFO - Running setup.py install for blessings 12:48:37 INFO - Successfully installed blessings 12:48:37 INFO - Cleaning up... 12:48:37 INFO - Return code: 0 12:48:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:48:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:48:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:48:37 INFO - Reading from file tmpfile_stdout 12:48:37 INFO - Current package versions: 12:48:37 INFO - blessings == 1.6 12:48:37 INFO - blobuploader == 1.2.4 12:48:37 INFO - docopt == 0.6.1 12:48:37 INFO - functools32 == 3.2.3-2 12:48:37 INFO - jsonschema == 2.5.1 12:48:37 INFO - manifestparser == 1.1 12:48:37 INFO - mozInstall == 1.12 12:48:37 INFO - mozcrash == 1.0 12:48:37 INFO - mozdebug == 0.1 12:48:37 INFO - mozdevice == 0.49 12:48:37 INFO - mozfile == 1.2 12:48:37 INFO - mozhttpd == 0.7 12:48:37 INFO - mozinfo == 0.9 12:48:37 INFO - mozleak == 0.1 12:48:37 INFO - mozlog == 3.4 12:48:37 INFO - moznetwork == 0.27 12:48:37 INFO - mozprocess == 0.24 12:48:37 INFO - mozprofile == 0.28 12:48:37 INFO - mozrunner == 6.13 12:48:37 INFO - mozscreenshot == 0.1 12:48:37 INFO - mozsystemmonitor == 0.3 12:48:37 INFO - moztest == 0.8 12:48:37 INFO - mozversion == 1.4 12:48:37 INFO - psutil == 3.1.1 12:48:37 INFO - requests == 1.2.3 12:48:37 INFO - wsgiref == 0.1.2 12:48:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:48: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')]} 12:48:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:48:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48: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')]} 12:48:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:48:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:37 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 0x10e40eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e411768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81434d2210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e1ecd30>, '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 0x10e113db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e1e1be8>, '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.jPzWAUIsxF/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.F7XSBgcGmV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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 12:48:37 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 12:48:37 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 12:48:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jPzWAUIsxF/Render', 12:48:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:48:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:48:37 INFO - 'HOME': '/Users/cltbld', 12:48:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:48:37 INFO - 'LOGNAME': 'cltbld', 12:48:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:48:37 INFO - 'MOZ_NO_REMOTE': '1', 12:48:37 INFO - 'NO_EM_RESTART': '1', 12:48:37 INFO - 'PAGER': '/bin/cat', 12:48:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:48:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:48:37 INFO - 'PWD': '/builds/slave/test', 12:48:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:48:37 INFO - 'SHELL': '/bin/bash', 12:48:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.F7XSBgcGmV/Listeners', 12:48:37 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 12:48:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:48:37 INFO - 'USER': 'cltbld', 12:48:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:48:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:48:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:48:37 INFO - 'XPC_FLAGS': '0x0', 12:48:37 INFO - 'XPC_SERVICE_NAME': '0', 12:48:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:48:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:48:38 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)) 12:48:38 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)) 12:48:38 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)) 12:48:38 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)) 12:48:38 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)) 12:48:38 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)) 12:48:38 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)) 12:48:38 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)) 12:48:38 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)) 12:48:38 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)) 12:48:38 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)) 12:48:38 INFO - Cleaning up... 12:48:38 INFO - Return code: 0 12:48:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:48:38 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')]} 12:48:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:48:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:38 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')]} 12:48:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:48:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:38 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 0x10e40eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e411768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81434d2210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e1ecd30>, '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 0x10e113db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e1e1be8>, '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.jPzWAUIsxF/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.F7XSBgcGmV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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 12:48:38 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 12:48:38 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 12:48:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jPzWAUIsxF/Render', 12:48:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:48:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:48:38 INFO - 'HOME': '/Users/cltbld', 12:48:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:48:38 INFO - 'LOGNAME': 'cltbld', 12:48:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:48:38 INFO - 'MOZ_NO_REMOTE': '1', 12:48:38 INFO - 'NO_EM_RESTART': '1', 12:48:38 INFO - 'PAGER': '/bin/cat', 12:48:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:48:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:48:38 INFO - 'PWD': '/builds/slave/test', 12:48:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:48:38 INFO - 'SHELL': '/bin/bash', 12:48:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.F7XSBgcGmV/Listeners', 12:48:38 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 12:48:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:48:38 INFO - 'USER': 'cltbld', 12:48:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:48:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:48:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:48:38 INFO - 'XPC_FLAGS': '0x0', 12:48:38 INFO - 'XPC_SERVICE_NAME': '0', 12:48:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:48:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:48:38 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:48:38 INFO - Cleaning up... 12:48:38 INFO - Return code: 0 12:48:38 INFO - Running post-action listener: _resource_record_post_action 12:48:38 INFO - Running post-action listener: _start_resource_monitoring 12:48:38 INFO - Starting resource monitoring. 12:48:38 INFO - [mozharness: 2017-01-19 20:48:38.345475Z] Finished create-virtualenv step (success) 12:48:38 INFO - [mozharness: 2017-01-19 20:48:38.346437Z] Running install step. 12:48:38 INFO - Running pre-action listener: _resource_record_pre_action 12:48:38 INFO - Running main action method: install 12:48:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:48:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:48:38 INFO - Reading from file tmpfile_stdout 12:48:38 INFO - Detecting whether we're running mozinstall >=1.0... 12:48:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:48:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:48:38 INFO - Reading from file tmpfile_stdout 12:48:38 INFO - Output received: 12:48:38 INFO - Usage: mozinstall [options] installer 12:48:38 INFO - Options: 12:48:38 INFO - -h, --help show this help message and exit 12:48:38 INFO - -d DEST, --destination=DEST 12:48:38 INFO - Directory to install application into. [default: 12:48:38 INFO - "/builds/slave/test"] 12:48:38 INFO - --app=APP Application being installed. [default: firefox] 12:48:38 INFO - mkdir: /builds/slave/test/build/application 12:48:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 12:48:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 12:49:00 INFO - Reading from file tmpfile_stdout 12:49:00 INFO - Output received: 12:49:00 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 12:49:00 INFO - Running post-action listener: _resource_record_post_action 12:49:00 INFO - [mozharness: 2017-01-19 20:49:00.788735Z] Finished install step (success) 12:49:00 INFO - [mozharness: 2017-01-19 20:49:00.788881Z] Running run-tests step. 12:49:00 INFO - Running pre-action listener: _resource_record_pre_action 12:49:00 INFO - Running main action method: run_tests 12:49:00 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:49:00 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:49:00 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:49:00 INFO - 2017-01-19 12:49:00.803 screenresolution[2544:22974] starting screenresolution argv=screenresolution get 12:49:00 INFO - 2017-01-19 12:49:00.806 screenresolution[2544:22974] Display 0: 1600x1200x32@60 12:49:00 INFO - 2017-01-19 12:49:00.812 screenresolution[2545:22976] starting screenresolution argv=screenresolution list 12:49:00 INFO - Available Modes on Display 0 12:49:00 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:49:00 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:49:00 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:49:00 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:49:01 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:49:01 INFO - Intel Iris: 12:49:01 INFO - Chipset Model: Intel Iris 12:49:01 INFO - Type: GPU 12:49:01 INFO - Bus: Built-In 12:49:01 INFO - VRAM (Dynamic, Max): 1536 MB 12:49:01 INFO - Vendor: Intel (0x8086) 12:49:01 INFO - Device ID: 0x0a2e 12:49:01 INFO - Revision ID: 0x0009 12:49:01 INFO - Displays: 12:49:01 INFO - Display: 12:49:01 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:49:01 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:49:01 INFO - Display Serial Number: 1600x1200 60 12:49:01 INFO - Main Display: Yes 12:49:01 INFO - Mirror: Off 12:49:01 INFO - Online: Yes 12:49:01 INFO - Rotation: Supported 12:49:01 INFO - Return code: 0 12:49:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:49:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:49:01 INFO - Python 2.7.3 12:49:01 INFO - Return code: 0 12:49:01 INFO - grabbing minidump binary from tooltool 12:49:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:49:01 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 0x10e1ecd30>, '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 0x10e113db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e1e1be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:49:01 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 12:49:01 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 12:49:01 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 12:49:01 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:49:01 INFO - Return code: 0 12:49:01 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 12:49:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:49:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:49:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 12:49:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:49:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/I5vM5wREQx6CvNpKF5tLdg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0314', '--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 12:49:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/I5vM5wREQx6CvNpKF5tLdg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0314 --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 12:49:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jPzWAUIsxF/Render', 12:49:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:49:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:49:01 INFO - 'HOME': '/Users/cltbld', 12:49:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:49:01 INFO - 'LOGNAME': 'cltbld', 12:49:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:49:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 12:49:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:49:01 INFO - 'MOZ_NO_REMOTE': '1', 12:49:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:49:01 INFO - 'NO_EM_RESTART': '1', 12:49:01 INFO - 'PAGER': '/bin/cat', 12:49:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:49:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:49:01 INFO - 'PWD': '/builds/slave/test', 12:49:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:49:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:49:01 INFO - 'SHELL': '/bin/bash', 12:49:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.F7XSBgcGmV/Listeners', 12:49:01 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 12:49:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:49:01 INFO - 'USER': 'cltbld', 12:49:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:49:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:49:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:49:01 INFO - 'XPC_FLAGS': '0x0', 12:49:01 INFO - 'XPC_SERVICE_NAME': '0', 12:49:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:49:01 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/I5vM5wREQx6CvNpKF5tLdg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0314', '--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 12:49:01 INFO - mozversion application_buildid: 20170119071129 12:49:01 INFO - mozversion application_changeset: a3978751f45108ff1ae002ecebdc0fa23fc52b84 12:49:01 INFO - mozversion application_display_name: Nightly 12:49:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:49:01 INFO - mozversion application_name: Firefox 12:49:01 INFO - mozversion application_remotingname: firefox 12:49:01 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 12:49:01 INFO - mozversion application_vendor: Mozilla 12:49:01 INFO - mozversion application_version: 53.0a1 12:49:01 INFO - mozversion platform_buildid: 20170119071129 12:49:01 INFO - mozversion platform_changeset: a3978751f45108ff1ae002ecebdc0fa23fc52b84 12:49:01 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 12:49:01 INFO - mozversion platform_version: 53.0a1 12:49:01 INFO - using testdate: 1484858941 12:49:01 INFO - actual date: 1484858941 12:49:01 INFO - starting webserver on 'localhost:56285' 12:49:01 INFO - SUITE-START | Running 2 tests 12:49:01 INFO - TEST-START | dromaeo_css 12:49:01 INFO - operating with platform_type : mac_ 12:49:01 INFO - Initialising browser for dromaeo_css test... 12:49:01 INFO - TEST-INFO | started process 2555 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/tmp2QnRmj/profile http://localhost:56285/getInfo.html) 12:49:04 INFO - PROCESS | 2555 | 2017-01-19 12:49:04.297 plugin-container[2557:23127] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4b47, name = 'com.apple.tsm.portname' 12:49:04 INFO - PROCESS | 2555 | See /usr/include/servers/bootstrap_defs.h for the error codes. 12:49:04 INFO - PROCESS | 2555 | 2017-01-19 12:49:04.301 plugin-container[2557:23127] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x931b, name = 'com.apple.CFPasteboardClient' 12:49:04 INFO - PROCESS | 2555 | See /usr/include/servers/bootstrap_defs.h for the error codes. 12:49:04 INFO - PROCESS | 2555 | 2017-01-19 12:49:04.301 plugin-container[2557:23127] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 12:49:04 INFO - PROCESS | 2555 | __metrics Screen width/height:1600/1200 12:49:04 INFO - PROCESS | 2555 | colorDepth:24 12:49:04 INFO - PROCESS | 2555 | Browser inner width/height: 1024/689 12:49:04 INFO - PROCESS | 2555 | __metrics 12:49:04 ERROR - PROCESS | 2555 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3269: TypeError: this.tabs is undefined 12:49:05 INFO - TEST-INFO | 2555: exit 0 12:49:05 INFO - Browser initialized. 12:49:05 INFO - Running cycle 1/1 for dromaeo_css test... 12:49:05 INFO - TEST-INFO | started process 2558 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/tmp2QnRmj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:49:07 INFO - PROCESS | 2558 | 2017-01-19 12:49:07.843 plugin-container[2559:23249] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8843, name = 'com.apple.tsm.portname' 12:49:07 INFO - PROCESS | 2558 | See /usr/include/servers/bootstrap_defs.h for the error codes. 12:49:07 INFO - PROCESS | 2558 | 2017-01-19 12:49:07.846 plugin-container[2559:23249] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f1b, name = 'com.apple.CFPasteboardClient' 12:49:07 INFO - PROCESS | 2558 | See /usr/include/servers/bootstrap_defs.h for the error codes. 12:49:07 INFO - PROCESS | 2558 | 2017-01-19 12:49:07.846 plugin-container[2559:23249] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 12:49:17 INFO - PROCESS | 2558 | RSS: Main: 232288256 12:49:17 INFO - PROCESS | 2558 | 12:52:21 INFO - PROCESS | 2558 | Cycle 1(1): loaded http://localhost:56285/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56285/tests/dromaeo/cssquery-ext.html) 12:52:22 INFO - PROCESS | 2558 | RSS: Main: 252432384 12:52:22 INFO - PROCESS | 2558 | 12:54:05 INFO - PROCESS | 2558 | ************************* 12:54:05 INFO - PROCESS | 2558 | A coding exception was thrown and uncaught in a Task. 12:54:05 INFO - PROCESS | 2558 | 12:54:05 ERROR - PROCESS | 2558 | Full message: TypeError: NetworkError when attempting to fetch resource. 12:54:05 INFO - PROCESS | 2558 | Full stack: 12:54:05 INFO - PROCESS | 2558 | ************************* 12:55:24 INFO - PROCESS | 2558 | Cycle 1(1): loaded http://localhost:56285/tests/dromaeo/cssquery-ext.html (next: http://localhost:56285/tests/dromaeo/cssquery-jquery.html) 12:55:25 INFO - PROCESS | 2558 | RSS: Main: 262475776 12:55:25 INFO - PROCESS | 2558 | 12:58:27 INFO - PROCESS | 2558 | Cycle 1(1): loaded http://localhost:56285/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56285/tests/dromaeo/cssquery-mootools.html) 12:58:28 INFO - PROCESS | 2558 | RSS: Main: 270966784 12:58:28 INFO - PROCESS | 2558 | 13:01:29 INFO - PROCESS | 2558 | Cycle 1(1): loaded http://localhost:56285/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56285/tests/dromaeo/cssquery-prototype.html) 13:01:30 INFO - PROCESS | 2558 | RSS: Main: 267161600 13:01:30 INFO - PROCESS | 2558 | 13:04:33 INFO - PROCESS | 2558 | Cycle 1(1): loaded http://localhost:56285/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56285/tests/dromaeo/cssquery-yui.html) 13:04:33 INFO - PROCESS | 2558 | RSS: Main: 271921152 13:04:33 INFO - PROCESS | 2558 | 13:07:36 INFO - PROCESS | 2558 | Cycle 1(1): loaded http://localhost:56285/tests/dromaeo/cssquery-yui.html (next: http://localhost:56285/tests/dromaeo/cssquery-dojo.html) 13:07:36 INFO - PROCESS | 2558 | RSS: Main: 274268160 13:07:36 INFO - PROCESS | 2558 | 13:07:36 INFO - PROCESS | 2558 | __start_tp_report 13:07:36 INFO - PROCESS | 2558 | _x_x_mozilla_page_load 13:07:36 INFO - PROCESS | 2558 | _x_x_mozilla_page_load_details 13:07:36 INFO - PROCESS | 2558 | |i|pagename|runs| 13:07:36 INFO - PROCESS | 2558 | |0;dojo.html;2821.7037211092834;3274.0832566881268;3282.5240340150663;3318.0875259303702;3320.4521253993084;4846.34574332465;5316.415194328621;5513.669179849212;5526.115821468566;5577.69322687252;4641.327007583898;5505.476979686923;5519.199716041172;5537.861553461165;5638.956792993289;5113.156329205676;5139.6659217150855;5139.768710408022;5140.640155189139;5208.114620514521;5086.084504789136;5105.872353191163;5160.483951604829;5189.195674670432;5261.394939581959;5195.376554813409;5198.584113270929;5204.3234379530795;5219.425863155069;5251.448597897223;4207.495100587918;4376.146651402978;5061.164907790247;5108.080545501808;5116.76974536143;4184.560621134798;5015.072211640858;5092.6435149539175;5144.022635699205;5185.61107916904;4771.642126840501;4833.275008748681;5450.400455949843;5547.55619550439;5558.6942718150485;6097.57316987811;6175.59858609189;6182.010878259457;6187.412195841388;6195.31851496335;6101.3079194897555;6111.144439778434;6136.447719705203;6143.634700640241;6155.384461553854;5028.5977121830165;5434;5693.975084484791;5724.16999535065;5747.453991870766;6222.160008398899;6257.68711564429;6276.372362763778;6293.685315734287;6299.181106456132;5158.871028224325;5981.252343457068;6061.181740465069;6061.969690151521;6075.878482430327;6110.346130329488;6115.909724157069;6121.788327166048;6143.112737013686;6265.498760099181;5995.220621319288;6052.061930400795;6069.848253793691;6167.691615419211;6198.783042593578;4919.827806026843;6097.451229389288;6107.431569637723;6122.2761798032625;6175.2898416681755;4877.780499877514;4910.361652985161;4912.410510738734;4925.039617274597;4935.259711043373;4214.852480163179;4290.742555446684;4296.162248361602;4323.329883868006;4346.9347959780625;4797.280407938837;5676.829695109153;5699.971500142473;5710.143478478261;5716.628419152742;6208.782692605737;6212.347703491158;6229.626222426669;6263.749450022039;6279;5533.363663178706;5582.469665381864;5587.55299576041;5665.971670141623;5709.743061562157;4477.171723231213;5299.4435584263865;5303.28405665238;5308.708021058879;5323.733813309319;5584.7207639617045;6255.906161407674;6309.62142271456;6310.085037669604;6333.588316759488;6145.692715364304;6197.380261973766;6207.162033125651;6211.440970312694;6227.097070924781;6168.629882207082;6252.218472690914;6264.404881536247;6279.717412716347;6291.748330066746;6134.294556126102;6146.647737497922;6175.96912015455;6177.444030037318;6204.968975155276;6089.238845144357;6148.1085242640465;6183.196184495987;6222.595531290452;6242.968785156045;4409.382686423967;5847.8245652630485;5886.146508756121;6041.78853740117;6107.236595425572;5940.554458415722;5951.345352011362;5980.671063091398;6050.576459647782;6083.422074902877;5654.971725141348;5759.827205183851;5779.739911703899;5790.971045144747;5851.941480585139;5662.320521537442;5983.042713165873;6020.036794112921;6066.545009124245;6086.756529738761;5672.943270567406;5734.827955161351;5831.591788574759;5851.678157701367;5857.209276747584 13:07:36 INFO - PROCESS | 2558 | |1;ext.html;420.98737037888867;438.66442171738606;505.063107934781;509.93370861787963;514.1259858240988;35083.47374789377;42591.36112958308;42704.35943460851;42718.35922461162;44482;43790.56209437905;43795;43892.56107438925;43909.56090439095;44324.113517729704;9218.953905230464;9392.154706076451;9458.716238512821;10690.786184276349;11058.391788451632;10908.454577271144;11029.83455248172;11033.117350611972;11041.83437248442;11056.281341712804;10958.616448424307;10991.120710343153;11001.22991390599;11028.117750579975;11034.282771619859;10934.945325273362;10945.56217751289;10994;11004.614838480615;11023.83464248029;10761.784764304748;10769.299995500267;10798.892011079868;10803.621873234477;10858.782824343469;37290;37763.81118094392;37792.62207377919;37822.4326635098;37846.621533784586;2946.395988822286;3414.400860823553;3943.132510847609;3979.56224815273;4019.698522610816;28141.57787633187;28569.714302857123;28966.42067158666;29004.564931526045;29229.853850730822;3035.605371301717;3069.554914537402;3115.672854350283;3225.951610725841;3254.9511757323658;331214;353985.99999999744;421352;422515;422617.88691056654;49730.756731082016;54280.18579721228;57016.71491642515;57073.14390284149;57268.427315727145;58882.70558647265;59313.81372372528;59330.40669593335;59672.10491842626;60177.398226017176;15215.31531081104;15344.693106137815;15516;15522.991005584601;15525.45660901863;10757.677269681923;11045.061169800496;11905.523779048914;12180.025597952319;12198.39008049594;14930.850691492946;17821.287148513915;18253.361132360304;18319.908400457913;18433.81566184321;6494.447971922439;6579.868402631921;7830.138684744674;7852.882206766903;7933.603319833986;827.3753316246195;866.5797088412115;876.2114097312342;876.8377850097752;903.0969030969031;30221.546676799866;30345.24136896551;30382.696173037988;30696.07911762651;30786.692133078832;1033.8811036730872;1068.4871261794226;1106.4301884529473;1116.6929094499078;1191.2316555821446;12822.551210707581;15615.453459129103;15667.921660391854;15811.367545298059;15973.361065557248;607861;614831;619652;621402;622463;61422.85771422822;61437.69281153655;61890;62382.37617623766;62399;1417.3692706745398;1446.768517037269;1458.9124652520882;1466.7579849324954;1477.2244571599997;28309;28649.71350286554;29631.555526667547;29779.255518612208;30487.579301001675;51872;52084.69788255324;52519.21221181762;52560.47439525556;52562;586907;587763;588087;588168;593277;22147.335579932627;24870.005199791805;25204.369890752878;25504.107356242443;25530.872345638152;34940.65059349374;43066.78466607647;43912.68261952147;44048.779756101016;45134.774326129475;35131.824340878135;35361.64638353686;35936;36351.63648363482;36578.634213657526;35116.29767404586;35629.109272267364;35792.64207357893;36694.44958325574;36738;36077.639223607424;36250.27499450049;36287;36538;36630.8168459156;25824.612630810178;30213;31880;31926.84036579895;31943.722251110627;23754.17021976827;24015.399615009763;24148.034078636658;24493.38766530851;24520 13:07:36 INFO - PROCESS | 2558 | |2;jquery.html;379.99050023749385;384.5615997762551;395.4404517607585;396.51385810965246;419.7817135089753;16718.331266749316;19905;20740.859252741095;21125.471863203427;21147;17748.467545973643;18498.815011849878;21561.13755449784;22042.88978555109;22311.107555697792;5415.756290966916;5843.2403787507565;5887.587868849182;5912.763489460416;5913.793017244398;5632.507385542814;5788.160716696077;5864.296284445851;5875.206847075633;5901.852453688649;5724.855028994197;5776.711164441782;5778.82663520093;5780;5782.421757824205;5784.2769653793275;5786.98727722649;5795.507381872525;6008.24896887889;7677.2322767723335;7550.5469671819865;7561.281678240558;7649.579273139975;7656;7667.501612395176;29250;29335.2666183345;29855.25361865949;29928.70071299281;29965.55051674205;2840.9857950710116;2947.6904924982996;2950.5574163875376;2954.3500429905384;3004.0987703688807;16377.344906203738;17066.317347306216;17072.06103664298;17121.22954467052;17393.739093913602;1695.6345897472956;1923.9551275687566;1943.5626983928644;1965.8401543089503;2052.158614967871;163078.18460907738;171305;171992;173944;174242;18982.810171898105;22870.313890583308;23057.769422305897;23251.18620848296;23519.88240058789;12096.75806483883;12726.109172357847;31693.841530792197;40536.79731601382;40929.38605920914;6282.1519094921605;6466;7538.924610753932;8231.218034286852;8337.458065225741;6955.826104347432;8277.793055173668;8395.832083358298;8430.620622072021;8567.528785916835;3598.208394153282;3608.4767708682093;3758.962410375916;4103.85636502721;4169;1774.7071733164141;1848.9815101849078;1996.7004949257728;2020.7170996060563;2063.8245749111493;972.9027097290215;994.2841154368842;1007.4106647611229;1011.6610935336597;1063.7340664833791;21406.678899816514;21913.342599722033;22032.33902982913;22036.669449958263;22152.563218046;951.2342564235856;996.6893535001594;1047.4436202518982;1056.6037735849056;1059.6238335390979;11446.198766086294;11523;11530.308181509135;11588.304701717923;11905.642830715093;543074;586928;723884;728226;739231;90770;143475;152521.23739381233;153021;158264.20867895818;986.3933680786265;999.975025598767;1006.2754816532085;1007.0734923870057;1021.4280003198085;18775.624487510446;19466.416007519798;19528.31650892212;19529.8047019528;19549.609007820047;57046.7147664259;58668.70665646644;61789.691051544454;63840.72318553696;63995.6800215996;86877;87548;94012;95289.5235523818;95859;8855.690050848189;12745.61763147107;13209.801852972405;13370.532031378854;13426.932865335611;14042.438302468196;14149.151050936976;14306.856931430968;14567.251929768496;14729.26353682333;11640.24338418034;11746.823797642872;11861.703457413634;12051.33717645538;12117.333546655018;8089.312408445113;8132.634031468717;11674.357910315015;11983.981361584363;12042.21725587834;8015.358771298399;8254.669813207405;8344.83310333802;8569.614367353359;8600.483970961763;12799.872001279868;13152.605421837361;13387.330633468482;13513.121647092907;13556.186628802303;11835.993940515153;11895.643130706092;12064.819027714415;12197.634070977885;12209.38953052326 13:07:36 INFO - PROCESS | 2558 | |3;mootools.html;1431.2342896550347;1436.3105709259548;1454.6217983324336;1465.0550394995228;1467.053750331036;7411.370033547141;7655;7925.682972681093;8341.791455213615;8367.079621241659;7879.724209652663;8115.553644549547;8133.75598732039;8210.261076503113;8214.466059706116;2252.3805953362794;2299.896504657286;2306.2274138163734;2314.9768502315014;2315.525317309956;2302.3208153594646;2334.26470661741;2337.240396871015;2340.110757911991;2352.717673879137;2256.1313894150708;2261.061659411342;2270.9545809083806;2276.5446910617943;2280.8403411761183;2107.8617546524856;2253.5154941687533;2273.2498275569105;2273.3407311879537;2281.4372155073743;2057.6193404220267;2307.8384513084093;2327.790498855094;2333.428310064028;2336.883155842218;8123.147069557729;8193.877091843628;8195.139510351446;8197.877031844528;8231.753047408587;4988.251762235657;5111.923321150186;5130.333056702642;5141.74291285438;5161.561267292284;3101.147184524274;3222.96777032229;3331.1838599543025;3380.138064793462;3494.318607871466;1098.3903933317006;1106.5684383090602;1160.7156246719524;1161.1233518693332;1239.1016513028073;10503.894961050368;10528;10539.314944528658;10594.31136976094;10639.521221545048;3726.6459686329754;3871.10964478166;4575.931361029588;4683.695559788603;4699.436067671902;9323.533823308808;9368.063193680577;9377.812443751087;9382.812343753223;9408.059194080537;5136.897262054738;5184.766685499161;5188.766505507186;5189.896202075937;5197.376314842243;4147.357159640261;4262.488501379854;4367.798855314813;4647.442306923191;4705.011947490997;3289.3256882339065;3748.1379282765115;3840.6735427488975;3887.7667339959694;3901.356276214393;1244.3156264054733;1256.221142891395;1259.6976725585976;1260.571405722059;1263.1915574032625;841.2302742990096;849.6516428264382;865.2256230673512;890.7060669978891;900.7342833863895;5487.835364939058;5523.061079616475;5604.243427137366;5782.508486778587;5846.356900740915;947.3321308477507;976.6532880827347;1016.1413605503337;1019.23557332001;1037.527924794217;3701.833417496219;3753.8686145985307;3816.7709937403843;3869.3035253654048;3879;9696.660616878375;9858.260630452745;9984.20126389887;9996.550155243032;9996.900030999743;9910.653127140515;9938.751531211632;9961.402315860927;9966.900330996597;9981.401115933068;6679.131712877295;7685.346745526581;7785.610719464004;7925.920740792633;7927.722529711547;4851.80592776285;5308.964751873347;5591.552675785846;5684.77260909559;5753.626014309057;8772.254358379354;8991.28069754405;9024.278057755233;9123.361364704408;9284.071592840932;9102.772430689021;9309.767255818388;9339.439633622005;9392.95303523478;9396.06039396055;6853.588784672936;7002.509824312249;7058.082449281561;7165.928340716526;7250.637468126467;7789.260020298063;7954.522728636069;7956.323712484504;7967.362610991223;8004.159563245776;6693.966530167513;6783.219929708147;7079.242062645331;7105.715771369088;7277.199508054004;6886.208086069965;6947.826304342229;6986;7057.752978645723;7076.752313668997;6328.430441260309;6354.904676429765;6411.102445657705;6414.069959855888;6432.067350234283;4989.376327959005;5048.368953880765;5074.416442109205;5098.923516147187;5125.769340379767;4920.803167873245;4962.181240095344;5121.743912804271;5147.305113809588;5190.6107041971245 13:07:36 INFO - PROCESS | 2558 | |4;prototype.html;318.94259033373993;349.93701133795923;350.87369543764515;365.3496775739184;374.7021118211022;4686.531346865312;4927.201571426431;5293.867653308669;5383.084875571152;5406.864828379293;4818.386210342243;5140.614453915952;5245.947540524594;5290.7354632268425;5319.468053194679;4111.280525907954;4162.542120366765;4175.478065241829;4177.415161877339;4183.51081106741;3617.0053235360224;4027.6173763492566;4160.854370097048;4174.248635245654;4212.1154557542795;3575.803330816804;4127.566605506424;4139.668826493888;4146.357314616239;4171.10321280926;3613.1147868772055;3795.6394142556414;3810.1427178884805;4149.555868629046;4156.459660244149;3312.320974200283;3698.9630103699155;3712.6472985066375;3715.4612581175847;3721.348763966295;3991.7604943703473;5012.498750124958;5134.255532947739;5153.896922061575;5265.973670131625;4178.827009954806;4629.56947602508;4784.545468180552;4807.735574543399;4821.662483626147;5531.806386776484;5609;5624.409437009096;5640.435956404327;5654.264945557051;3494.0391392367046;3500.8949731508096;3762.777097443342;4042.393640953851;4046.5953404659595;4705.435347758256;4841.394825646794;4846.418429788448;5313.123334649778;6108.450239478469;4106.445629839993;4126.855560055444;4157.771322577227;4179.561146079679;4195.517515485697;3457.6888080072913;3613.9638603614153;3944.6055394460323;4115.464989551339;4224.429701990253;4774.259989701602;4776.593989510861;4778.283257511332;4789.209780386267;4809;4697.553732395417;5072.771725272371;5396.75874548856;5585.057224356393;5676.801311954062;1147.913906457019;1210.5460452330376;1274.7634794249564;1293.379177994549;1360.4354193009988;860.2816648098783;901.5620085962879;955.5222388805597;972.7324985628867;981.6711401680374;4597;4645.419322584677;4649.814007439732;4657.371254880615;5079.212722028092;4563.680542362003;5056;5167.431582525919;5615.494605485526;5630.986422444;4084.469019027567;4307.892302692458;4457.710248833815;4951.8266860659705;5007.774650140753;2627.4745050989877;2717.4972630063503;2898.768023590008;2909;2909.2435966648823;5108.029474399927;5495.2856128703015;5530.668159910419;5640.435956404327;5825.766699481828;4689.882752931204;4849.387206531086;5445.264889239902;5737.51231145349;5891.440313170242;4677.391939047902;4963.503649635152;5163.509466600742;5207.921881171786;5703.486686198262;5443.374011988672;5497.725113744376;5501.642393244426;5518.868631930364;5539.701024074964;4793.328933949319;4831.212451393007;5118.283440318284;5474.084070575426;5575.961101199775;4827.758612069312;5080.974595127001;5264.815731449381;5265.52610265078;5597.780667876604;3882.9223415532097;3886.417037444406;3906.9609303907732;3950.664193543581;3955.268275369066;4669.392978912855;4980.676256043345;5082.974585127198;5173.767180476812;5501.504864562208;4624.722516649012;4798.880027999188;4958.801647934187;5173;5208.5312321891215;4726.71639701619;5045.697258164522;5159.170137744325;5313.893722125613;5628.071368224197;4842.346283251716;5512.944870551403;5523.061079616556;5530.668159910419;5604.719764011702;4413.933790993202;5244.842654720364;5683.9715801420725;5695.316562012585;5702.743376548148;4699.718016918996;4884.8290309838985;5344.114178343651;5388;5557.3331200256225 13:07:36 INFO - PROCESS | 2558 | |5;yui.html;655.9836004099897;723.1358526560762;734.3097488360944;793.1037927142328;818.9569700575055;14524.63688407789;15491.535253942386;16625.418110366125;17516.386926457577;17551.82448175518;16486.587835304123;16502.504924852274;16523;16569.17154142291;16652.75020874688;690.3510699942063;868.9956550217256;897.6364572348177;898.8786513820615;904.1997831918767;713.6289129652604;858.3347905373323;882.9117088291184;897.7979954510248;897.9730608081735;778.6457161991309;937.2408349237139;940.8917974432925;944.8441007233798;945.2674177512414;929.972100836976;939.3893968920256;939.6194541210821;941.0683423410842;943.4056544377067;682.5597489619217;693.7225109956007;699.6117154978984;705.3546005405049;707.7841258416181;15094.094354338775;15447.691046179014;15452.768208476882;15530.145841978687;15632.2183890805;11622.41040150236;13501.59495215145;13741.725165496635;14031.298435078204;14373.425062997467;11616.494104973357;11769.823452648217;11787.823182652268;11796.35120068396;11892.286462812259;3686.4654625079484;3719.2189640175325;3758.699304055669;3794.6015668354703;3818.179091495314;109750;110938;110995.56537694305;111457.44271278592;112329.43835280853;10735.033846953655;10791.6222932197;10805.297655652357;10835.458227088615;11144.33134011962;21651.35045948624;21751.782482174975;22192.223272185394;22269.66595501069;22291.331260062223;7637.809054773564;7667.194944530744;7716.498427602188;7737.767866964;7788.221177882279;4328.935065974013;4348.543402942709;4350.477942646839;4426.889327766831;4498.865034048984;2767.266674331304;3138.8587513561943;3145.8360406649686;3303.702666760003;3930.292547341449;624.2166081567603;685.2736099734298;717.8026042838156;734.3794493652855;740.9184989651134;519.5376115257424;662.6123717625147;671.9596824190564;686.4062585863193;696.7282759723712;9971.762968580108;10143.797124057477;10267.332623379456;10484.263183491877;10559.683209503728;668.8528523724773;703.665758764593;705.5660768627359;710.7761055267574;731.9377852882565;4791.401074865642;4968.428630707443;4987.975060124676;5022.146235140035;5037.4458809530925;90453.54773226092;106795;106802;109209;110258;41976.370354444705;66208;93506;93791;94805;78342.6082869582;81066.78399824008;81644.18355816366;82445.58777206075;83881;7703.460757747128;9671.742673452407;9839.884424848691;9874.605015799287;9935.155511781579;49431;51075.97848042944;52155.73922130365;52158;53153.7342313286;58169;70023;71487.64256178893;72298.91551626835;73455.63272183605;9772.778402699663;11369.715757106138;11513.481893314989;11574.247673901169;12026.939865300617;12762.61712148637;12765.680857978625;12952.740945181233;13344.266065366499;13703.520376787163;11907.82138267944;12167.75664486723;12226.572069977508;12272.325022123869;12574.748505030031;10109.292349535463;11960.890228008338;12135.878641213474;12193.817092743793;12223.877761222275;12022.879771202175;12064.698382540155;12066.818997714865;12075.990476285031;12158.331291779037;8714.956425217833;9525.476098814355;9576.76058098553;9693.806123877624;10105.242106842163;8741.519216443157;9788.00113224974;9909.950450247703;10044.748881278027;10075.546600403146 13:07:36 INFO - PROCESS | 2558 | __end_tp_report 13:07:36 INFO - PROCESS | 2558 | __start_cc_report 13:07:36 INFO - PROCESS | 2558 | _x_x_mozilla_cycle_collect,384 13:07:36 INFO - PROCESS | 2558 | __end_cc_report 13:07:36 INFO - PROCESS | 2558 | __startTimestamp1484860056942__endTimestamp 13:07:36 INFO - PROCESS | 2558 | 13:07:36 INFO - PROCESS | 2558 | ------- Summary: start ------- 13:07:36 INFO - PROCESS | 2558 | Number of tests: 6 13:07:36 INFO - PROCESS | 2558 | 13:07:36 INFO - PROCESS | 2558 | [#0] dojo.html Cycles:165 Average:5585.81 Median:5747.45 stddev:703.54 (12.2%) stddev-sans-first:671.46 13:07:36 INFO - PROCESS | 2558 | Values: 2821.7 3274.1 3282.5 3318.1 3320.5 4846.3 5316.4 5513.7 5526.1 5577.7 4641.3 5505.5 5519.2 5537.9 5639.0 5113.2 5139.7 5139.8 5140.6 5208.1 5086.1 5105.9 5160.5 5189.2 5261.4 5195.4 5198.6 5204.3 5219.4 5251.4 4207.5 4376.1 5061.2 5108.1 5116.8 4184.6 5015.1 5092.6 5144.0 5185.6 4771.6 4833.3 5450.4 5547.6 5558.7 6097.6 6175.6 6182.0 6187.4 6195.3 6101.3 6111.1 6136.4 6143.6 6155.4 5028.6 5434.0 5694.0 5724.2 5747.5 6222.2 6257.7 6276.4 6293.7 6299.2 5158.9 5981.3 6061.2 6062.0 6075.9 6110.3 6115.9 6121.8 6143.1 6265.5 5995.2 6052.1 6069.8 6167.7 6198.8 4919.8 6097.5 6107.4 6122.3 6175.3 4877.8 4910.4 4912.4 4925.0 4935.3 4214.9 4290.7 4296.2 4323.3 4346.9 4797.3 5676.8 5700.0 5710.1 5716.6 6208.8 6212.3 6229.6 6263.7 6279.0 5533.4 5582.5 5587.6 5666.0 5709.7 4477.2 5299.4 5303.3 5308.7 5323.7 5584.7 6255.9 6309.6 6310.1 6333.6 6145.7 6197.4 6207.2 6211.4 6227.1 6168.6 6252.2 6264.4 6279.7 6291.7 6134.3 6146.6 6176.0 6177.4 6205.0 6089.2 6148.1 6183.2 6222.6 6243.0 4409.4 5847.8 5886.1 6041.8 6107.2 5940.6 5951.3 5980.7 6050.6 6083.4 5655.0 5759.8 5779.7 5791.0 5851.9 5662.3 5983.0 6020.0 6066.5 6086.8 5672.9 5734.8 5831.6 5851.7 5857.2 13:07:36 INFO - PROCESS | 2558 | 13:07:36 INFO - PROCESS | 2558 | [#1] ext.html Cycles:180 Average:66616.95 Median:35012.06 stddev:144950.73 (414.0%) stddev-sans-first:145272.15 13:07:36 INFO - PROCESS | 2558 | Values: 421.0 438.7 505.1 509.9 514.1 35083.5 42591.4 42704.4 42718.4 44482.0 43790.6 43795.0 43892.6 43909.6 44324.1 9219.0 9392.2 9458.7 10690.8 11058.4 10908.5 11029.8 11033.1 11041.8 11056.3 10958.6 10991.1 11001.2 11028.1 11034.3 10934.9 10945.6 10994.0 11004.6 11023.8 10761.8 10769.3 10798.9 10803.6 10858.8 37290.0 37763.8 37792.6 37822.4 37846.6 2946.4 3414.4 3943.1 3979.6 4019.7 28141.6 28569.7 28966.4 29004.6 29229.9 3035.6 3069.6 3115.7 3226.0 3255.0 331214.0 353986.0 421352.0 422515.0 422617.9 49730.8 54280.2 57016.7 57073.1 57268.4 58882.7 59313.8 59330.4 59672.1 60177.4 15215.3 15344.7 15516.0 15523.0 15525.5 10757.7 11045.1 11905.5 12180.0 12198.4 14930.9 17821.3 18253.4 18319.9 18433.8 6494.4 6579.9 7830.1 7852.9 7933.6 827.4 866.6 876.2 876.8 903.1 30221.5 30345.2 30382.7 30696.1 30786.7 1033.9 1068.5 1106.4 1116.7 1191.2 12822.6 15615.5 15667.9 15811.4 15973.4 607861.0 614831.0 619652.0 621402.0 622463.0 61422.9 61437.7 61890.0 62382.4 62399.0 1417.4 1446.8 1458.9 1466.8 1477.2 28309.0 28649.7 29631.6 29779.3 30487.6 51872.0 52084.7 52519.2 52560.5 52562.0 586907.0 587763.0 588087.0 588168.0 593277.0 22147.3 24870.0 25204.4 25504.1 25530.9 34940.7 43066.8 43912.7 44048.8 45134.8 35131.8 35361.6 35936.0 36351.6 36578.6 35116.3 35629.1 35792.6 36694.4 36738.0 36077.6 36250.3 36287.0 36538.0 36630.8 25824.6 30213.0 31880.0 31926.8 31943.7 23754.2 24015.4 24148.0 24493.4 24520.0 13:07:36 INFO - PROCESS | 2558 | 13:07:36 INFO - PROCESS | 2558 | [#2] jquery.html Cycles:180 Average:40583.99 Median:23385.53 stddev:112866.52 (482.6%) stddev-sans-first:113142.77 13:07:36 INFO - PROCESS | 2558 | Values: 380.0 384.6 395.4 396.5 419.8 16718.3 19905.0 20740.9 21125.5 21147.0 17748.5 18498.8 21561.1 22042.9 22311.1 5415.8 5843.2 5887.6 5912.8 5913.8 5632.5 5788.2 5864.3 5875.2 5901.9 5724.9 5776.7 5778.8 5780.0 5782.4 5784.3 5787.0 5795.5 6008.2 7677.2 7550.5 7561.3 7649.6 7656.0 7667.5 29250.0 29335.3 29855.3 29928.7 29965.6 2841.0 2947.7 2950.6 2954.4 3004.1 16377.3 17066.3 17072.1 17121.2 17393.7 1695.6 1924.0 1943.6 1965.8 2052.2 163078.2 171305.0 171992.0 173944.0 174242.0 18982.8 22870.3 23057.8 23251.2 23519.9 12096.8 12726.1 31693.8 40536.8 40929.4 6282.2 6466.0 7538.9 8231.2 8337.5 6955.8 8277.8 8395.8 8430.6 8567.5 3598.2 3608.5 3759.0 4103.9 4169.0 1774.7 1849.0 1996.7 2020.7 2063.8 972.9 994.3 1007.4 1011.7 1063.7 21406.7 21913.3 22032.3 22036.7 22152.6 951.2 996.7 1047.4 1056.6 1059.6 11446.2 11523.0 11530.3 11588.3 11905.6 543074.0 586928.0 723884.0 728226.0 739231.0 90770.0 143475.0 152521.2 153021.0 158264.2 986.4 1000.0 1006.3 1007.1 1021.4 18775.6 19466.4 19528.3 19529.8 19549.6 57046.7 58668.7 61789.7 63840.7 63995.7 86877.0 87548.0 94012.0 95289.5 95859.0 8855.7 12745.6 13209.8 13370.5 13426.9 14042.4 14149.2 14306.9 14567.3 14729.3 11640.2 11746.8 11861.7 12051.3 12117.3 8089.3 8132.6 11674.4 11984.0 12042.2 8015.4 8254.7 8344.8 8569.6 8600.5 12799.9 13152.6 13387.3 13513.1 13556.2 11836.0 11895.6 12064.8 12197.6 12209.4 13:07:36 INFO - PROCESS | 2558 | 13:07:36 INFO - PROCESS | 2558 | [#3] mootools.html Cycles:180 Average:5377.13 Median:5189.33 stddev:2924.21 (56.4%) stddev-sans-first:2917.38 13:07:36 INFO - PROCESS | 2558 | Values: 1431.2 1436.3 1454.6 1465.1 1467.1 7411.4 7655.0 7925.7 8341.8 8367.1 7879.7 8115.6 8133.8 8210.3 8214.5 2252.4 2299.9 2306.2 2315.0 2315.5 2302.3 2334.3 2337.2 2340.1 2352.7 2256.1 2261.1 2271.0 2276.5 2280.8 2107.9 2253.5 2273.2 2273.3 2281.4 2057.6 2307.8 2327.8 2333.4 2336.9 8123.1 8193.9 8195.1 8197.9 8231.8 4988.3 5111.9 5130.3 5141.7 5161.6 3101.1 3223.0 3331.2 3380.1 3494.3 1098.4 1106.6 1160.7 1161.1 1239.1 10503.9 10528.0 10539.3 10594.3 10639.5 3726.6 3871.1 4575.9 4683.7 4699.4 9323.5 9368.1 9377.8 9382.8 9408.1 5136.9 5184.8 5188.8 5189.9 5197.4 4147.4 4262.5 4367.8 4647.4 4705.0 3289.3 3748.1 3840.7 3887.8 3901.4 1244.3 1256.2 1259.7 1260.6 1263.2 841.2 849.7 865.2 890.7 900.7 5487.8 5523.1 5604.2 5782.5 5846.4 947.3 976.7 1016.1 1019.2 1037.5 3701.8 3753.9 3816.8 3869.3 3879.0 9696.7 9858.3 9984.2 9996.6 9996.9 9910.7 9938.8 9961.4 9966.9 9981.4 6679.1 7685.3 7785.6 7925.9 7927.7 4851.8 5309.0 5591.6 5684.8 5753.6 8772.3 8991.3 9024.3 9123.4 9284.1 9102.8 9309.8 9339.4 9393.0 9396.1 6853.6 7002.5 7058.1 7165.9 7250.6 7789.3 7954.5 7956.3 7967.4 8004.2 6694.0 6783.2 7079.2 7105.7 7277.2 6886.2 6947.8 6986.0 7057.8 7076.8 6328.4 6354.9 6411.1 6414.1 6432.1 4989.4 5048.4 5074.4 5098.9 5125.8 4920.8 4962.2 5121.7 5147.3 5190.6 13:07:36 INFO - PROCESS | 2558 | 13:07:36 INFO - PROCESS | 2558 | [#4] prototype.html Cycles:180 Average:4417.29 Median:4820.02 stddev:1292.01 (26.8%) stddev-sans-first:1258.48 13:07:36 INFO - PROCESS | 2558 | Values: 318.9 349.9 350.9 365.3 374.7 4686.5 4927.2 5293.9 5383.1 5406.9 4818.4 5140.6 5245.9 5290.7 5319.5 4111.3 4162.5 4175.5 4177.4 4183.5 3617.0 4027.6 4160.9 4174.2 4212.1 3575.8 4127.6 4139.7 4146.4 4171.1 3613.1 3795.6 3810.1 4149.6 4156.5 3312.3 3699.0 3712.6 3715.5 3721.3 3991.8 5012.5 5134.3 5153.9 5266.0 4178.8 4629.6 4784.5 4807.7 4821.7 5531.8 5609.0 5624.4 5640.4 5654.3 3494.0 3500.9 3762.8 4042.4 4046.6 4705.4 4841.4 4846.4 5313.1 6108.5 4106.4 4126.9 4157.8 4179.6 4195.5 3457.7 3614.0 3944.6 4115.5 4224.4 4774.3 4776.6 4778.3 4789.2 4809.0 4697.6 5072.8 5396.8 5585.1 5676.8 1147.9 1210.5 1274.8 1293.4 1360.4 860.3 901.6 955.5 972.7 981.7 4597.0 4645.4 4649.8 4657.4 5079.2 4563.7 5056.0 5167.4 5615.5 5631.0 4084.5 4307.9 4457.7 4951.8 5007.8 2627.5 2717.5 2898.8 2909.0 2909.2 5108.0 5495.3 5530.7 5640.4 5825.8 4689.9 4849.4 5445.3 5737.5 5891.4 4677.4 4963.5 5163.5 5207.9 5703.5 5443.4 5497.7 5501.6 5518.9 5539.7 4793.3 4831.2 5118.3 5474.1 5576.0 4827.8 5081.0 5264.8 5265.5 5597.8 3882.9 3886.4 3907.0 3950.7 3955.3 4669.4 4980.7 5083.0 5173.8 5501.5 4624.7 4798.9 4958.8 5173.0 5208.5 4726.7 5045.7 5159.2 5313.9 5628.1 4842.3 5512.9 5523.1 5530.7 5604.7 4413.9 5244.8 5684.0 5695.3 5702.7 4699.7 4884.8 5344.1 5388.0 5557.3 13:07:36 INFO - PROCESS | 2558 | 13:07:36 INFO - PROCESS | 2558 | [#5] yui.html Cycles:180 Average:20357.99 Median:4645.13 stddev:29913.01 (644.0%) stddev-sans-first:29960.35 13:07:36 INFO - PROCESS | 2558 | Values: 656.0 723.1 734.3 793.1 819.0 14524.6 15491.5 16625.4 17516.4 17551.8 16486.6 16502.5 16523.0 16569.2 16652.8 690.4 869.0 897.6 898.9 904.2 713.6 858.3 882.9 897.8 898.0 778.6 937.2 940.9 944.8 945.3 930.0 939.4 939.6 941.1 943.4 682.6 693.7 699.6 705.4 707.8 15094.1 15447.7 15452.8 15530.1 15632.2 11622.4 13501.6 13741.7 14031.3 14373.4 11616.5 11769.8 11787.8 11796.4 11892.3 3686.5 3719.2 3758.7 3794.6 3818.2 109750.0 110938.0 110995.6 111457.4 112329.4 10735.0 10791.6 10805.3 10835.5 11144.3 21651.4 21751.8 22192.2 22269.7 22291.3 7637.8 7667.2 7716.5 7737.8 7788.2 4328.9 4348.5 4350.5 4426.9 4498.9 2767.3 3138.9 3145.8 3303.7 3930.3 624.2 685.3 717.8 734.4 740.9 519.5 662.6 672.0 686.4 696.7 9971.8 10143.8 10267.3 10484.3 10559.7 668.9 703.7 705.6 710.8 731.9 4791.4 4968.4 4988.0 5022.1 5037.4 90453.5 106795.0 106802.0 109209.0 110258.0 41976.4 66208.0 93506.0 93791.0 94805.0 78342.6 81066.8 81644.2 82445.6 83881.0 7703.5 9671.7 9839.9 9874.6 9935.2 49431.0 51076.0 52155.7 52158.0 53153.7 58169.0 70023.0 71487.6 72298.9 73455.6 9772.8 11369.7 11513.5 11574.2 12026.9 12762.6 12765.7 12952.7 13344.3 13703.5 11907.8 12167.8 12226.6 12272.3 12574.7 10109.3 11960.9 12135.9 12193.8 12223.9 12022.9 12064.7 12066.8 12076.0 12158.3 8715.0 9525.5 9576.8 9693.8 10105.2 8741.5 9788.0 9910.0 10044.7 10075.5 13:07:36 INFO - PROCESS | 2558 | -------- Summary: end -------- 13:07:36 INFO - PROCESS | 2558 | 13:07:37 INFO - TEST-INFO | 2558: exit 0 13:07:37 INFO - TEST-OK | dromaeo_css | took 1116348ms 13:07:37 INFO - TEST-START | kraken 13:07:37 INFO - operating with platform_type : mac_ 13:07:37 INFO - Initialising browser for kraken test... 13:07:37 INFO - TEST-INFO | started process 2674 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/tmp32Q4kF/profile http://localhost:56285/getInfo.html) 13:07:40 INFO - PROCESS | 2674 | 2017-01-19 13:07:40.646 plugin-container[2675:25613] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x484b, name = 'com.apple.tsm.portname' 13:07:40 INFO - PROCESS | 2674 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:07:40 INFO - PROCESS | 2674 | 2017-01-19 13:07:40.649 plugin-container[2675:25613] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x451f, name = 'com.apple.CFPasteboardClient' 13:07:40 INFO - PROCESS | 2674 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:07:40 INFO - PROCESS | 2674 | 2017-01-19 13:07:40.649 plugin-container[2675:25613] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 13:07:40 INFO - PROCESS | 2674 | __metrics Screen width/height:1600/1200 13:07:40 INFO - PROCESS | 2674 | colorDepth:24 13:07:40 INFO - PROCESS | 2674 | Browser inner width/height: 1024/689 13:07:40 INFO - PROCESS | 2674 | __metrics 13:07:40 ERROR - PROCESS | 2674 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3269: TypeError: this.tabs is undefined 13:07:41 INFO - TEST-INFO | 2674: exit 0 13:07:41 INFO - Browser initialized. 13:07:41 INFO - Running cycle 1/1 for kraken test... 13:07:41 INFO - TEST-INFO | started process 2677 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/tmp32Q4kF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:07:43 INFO - PROCESS | 2677 | 2017-01-19 13:07:43.920 plugin-container[2678:25734] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4747, name = 'com.apple.tsm.portname' 13:07:43 INFO - PROCESS | 2677 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:07:43 INFO - PROCESS | 2677 | 2017-01-19 13:07:43.921 plugin-container[2678:25734] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x430f, name = 'com.apple.CFPasteboardClient' 13:07:43 INFO - PROCESS | 2677 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:07:43 INFO - PROCESS | 2677 | 2017-01-19 13:07:43.921 plugin-container[2678:25734] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 13:07:53 INFO - PROCESS | 2677 | RSS: Main: 232222720 13:07:53 INFO - PROCESS | 2677 | 13:07:56 INFO - PROCESS | 2677 | Cycle 1(1): loaded http://localhost:56285/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56285/tests/kraken/driver.html?testName=audio-beat-detection) 13:07:57 INFO - PROCESS | 2677 | RSS: Main: 245518336 13:07:57 INFO - PROCESS | 2677 | 13:08:00 INFO - PROCESS | 2677 | Cycle 1(1): loaded http://localhost:56285/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56285/tests/kraken/driver.html?testName=audio-dft) 13:08:01 INFO - PROCESS | 2677 | RSS: Main: 253509632 13:08:01 INFO - PROCESS | 2677 | 13:08:04 INFO - PROCESS | 2677 | Cycle 1(1): loaded http://localhost:56285/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56285/tests/kraken/driver.html?testName=audio-fft) 13:08:05 INFO - PROCESS | 2677 | RSS: Main: 256278528 13:08:05 INFO - PROCESS | 2677 | 13:08:07 INFO - PROCESS | 2677 | Cycle 1(1): loaded http://localhost:56285/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56285/tests/kraken/driver.html?testName=audio-oscillator) 13:08:07 INFO - PROCESS | 2677 | RSS: Main: 257413120 13:08:07 INFO - PROCESS | 2677 | 13:08:09 INFO - PROCESS | 2677 | Cycle 1(1): loaded http://localhost:56285/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56285/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:08:10 INFO - PROCESS | 2677 | RSS: Main: 259178496 13:08:10 INFO - PROCESS | 2677 | 13:08:13 INFO - PROCESS | 2677 | Cycle 1(1): loaded http://localhost:56285/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56285/tests/kraken/driver.html?testName=imaging-darkroom) 13:08:14 INFO - PROCESS | 2677 | RSS: Main: 265138176 13:08:14 INFO - PROCESS | 2677 | 13:08:17 INFO - PROCESS | 2677 | Cycle 1(1): loaded http://localhost:56285/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56285/tests/kraken/driver.html?testName=imaging-desaturate) 13:08:17 INFO - PROCESS | 2677 | RSS: Main: 264302592 13:08:17 INFO - PROCESS | 2677 | 13:08:20 INFO - PROCESS | 2677 | Cycle 1(1): loaded http://localhost:56285/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56285/tests/kraken/driver.html?testName=json-parse-financial) 13:08:21 INFO - PROCESS | 2677 | RSS: Main: 263958528 13:08:21 INFO - PROCESS | 2677 | 13:08:22 INFO - PROCESS | 2677 | Cycle 1(1): loaded http://localhost:56285/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56285/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:08:23 INFO - PROCESS | 2677 | RSS: Main: 263602176 13:08:23 INFO - PROCESS | 2677 | 13:08:25 INFO - PROCESS | 2677 | Cycle 1(1): loaded http://localhost:56285/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56285/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:08:26 INFO - PROCESS | 2677 | RSS: Main: 263626752 13:08:26 INFO - PROCESS | 2677 | 13:08:28 INFO - PROCESS | 2677 | Cycle 1(1): loaded http://localhost:56285/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56285/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:08:28 INFO - PROCESS | 2677 | RSS: Main: 263671808 13:08:28 INFO - PROCESS | 2677 | 13:08:31 INFO - PROCESS | 2677 | Cycle 1(1): loaded http://localhost:56285/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56285/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:08:32 INFO - PROCESS | 2677 | RSS: Main: 264036352 13:08:32 INFO - PROCESS | 2677 | 13:08:35 INFO - PROCESS | 2677 | Cycle 1(1): loaded http://localhost:56285/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56285/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:08:36 INFO - PROCESS | 2677 | RSS: Main: 263757824 13:08:36 INFO - PROCESS | 2677 | 13:08:37 INFO - PROCESS | 2677 | Cycle 1(1): loaded http://localhost:56285/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56285/tests/kraken/driver.html?testName=ai-astar) 13:08:38 INFO - PROCESS | 2677 | RSS: Main: 265588736 13:08:38 INFO - PROCESS | 2677 | 13:08:38 INFO - PROCESS | 2677 | __start_tp_report 13:08:38 INFO - PROCESS | 2677 | _x_x_mozilla_page_load 13:08:38 INFO - PROCESS | 2677 | _x_x_mozilla_page_load_details 13:08:38 INFO - PROCESS | 2677 | |i|pagename|runs| 13:08:38 INFO - PROCESS | 2677 | |0;ai-astar;105;118;117;118;118;119;120;170;166;119 13:08:38 INFO - PROCESS | 2677 | |1;audio-beat-detection;173;144;103;186;149;111;130;149;123;133 13:08:38 INFO - PROCESS | 2677 | |2;audio-dft;205;242;277;216;200;200;196;197;252;278 13:08:38 INFO - PROCESS | 2677 | |3;audio-fft;82;59;59;86;61;58;60;57;75;70 13:08:38 INFO - PROCESS | 2677 | |4;audio-oscillator;86;70;82;72;69;70;79;71;71;82 13:08:38 INFO - PROCESS | 2677 | |5;imaging-gaussian-blur;92;87;113;87;82;131;124;92;96;132 13:08:38 INFO - PROCESS | 2677 | |6;imaging-darkroom;97;156;122;96;95;95;97;95;96;97 13:08:38 INFO - PROCESS | 2677 | |7;imaging-desaturate;93;95;93;93;110;92;92;94;92;106 13:08:38 INFO - PROCESS | 2677 | |8;json-parse-financial;60;61;61;62;62;60;62;62;64;66 13:08:38 INFO - PROCESS | 2677 | |9;json-stringify-tinderbox;69;69;74;74;82;71;69;71;71;74 13:08:38 INFO - PROCESS | 2677 | |10;stanford-crypto-aes;88;89;94;94;86;75;100;107;80;89 13:08:38 INFO - PROCESS | 2677 | |11;stanford-crypto-ccm;140;138;139;139;145;168;147;162;183;142 13:08:38 INFO - PROCESS | 2677 | |12;stanford-crypto-pbkdf2;181;182;173;172;180;177;172;181;178;175 13:08:38 INFO - PROCESS | 2677 | |13;stanford-crypto-sha256-iterative;65;70;66;69;70;68;71;68;67;64 13:08:38 INFO - PROCESS | 2677 | __end_tp_report 13:08:38 INFO - PROCESS | 2677 | __start_cc_report 13:08:38 INFO - PROCESS | 2677 | _x_x_mozilla_cycle_collect,913 13:08:38 INFO - PROCESS | 2677 | __end_cc_report 13:08:38 INFO - PROCESS | 2677 | __startTimestamp1484860118080__endTimestamp 13:08:38 INFO - PROCESS | 2677 | 13:08:38 INFO - PROCESS | 2677 | ------- Summary: start ------- 13:08:38 INFO - PROCESS | 2677 | Number of tests: 14 13:08:38 INFO - PROCESS | 2677 | 13:08:38 INFO - PROCESS | 2677 | [#0] ai-astar Cycles:10 Average:127.00 Median:119.00 stddev:22.05 (18.5%) stddev-sans-first:21.90 13:08:38 INFO - PROCESS | 2677 | Values: 105.0 118.0 117.0 118.0 118.0 119.0 120.0 170.0 166.0 119.0 13:08:38 INFO - PROCESS | 2677 | 13:08:38 INFO - PROCESS | 2677 | [#1] audio-beat-detection Cycles:10 Average:140.10 Median:146.50 stddev:25.89 (17.7%) stddev-sans-first:24.57 13:08:38 INFO - PROCESS | 2677 | Values: 173.0 144.0 103.0 186.0 149.0 111.0 130.0 149.0 123.0 133.0 13:08:38 INFO - PROCESS | 2677 | 13:08:38 INFO - PROCESS | 2677 | [#2] audio-dft Cycles:10 Average:226.30 Median:229.00 stddev:33.12 (14.5%) stddev-sans-first:34.22 13:08:38 INFO - PROCESS | 2677 | Values: 205.0 242.0 277.0 216.0 200.0 200.0 196.0 197.0 252.0 278.0 13:08:38 INFO - PROCESS | 2677 | 13:08:38 INFO - PROCESS | 2677 | [#3] audio-fft Cycles:10 Average:66.70 Median:65.50 stddev:10.81 (16.5%) stddev-sans-first:9.95 13:08:38 INFO - PROCESS | 2677 | Values: 82.0 59.0 59.0 86.0 61.0 58.0 60.0 57.0 75.0 70.0 13:08:38 INFO - PROCESS | 2677 | 13:08:38 INFO - PROCESS | 2677 | [#4] audio-oscillator Cycles:10 Average:75.20 Median:75.50 stddev:6.34 (8.4%) stddev-sans-first:5.39 13:08:38 INFO - PROCESS | 2677 | Values: 86.0 70.0 82.0 72.0 69.0 70.0 79.0 71.0 71.0 82.0 13:08:38 INFO - PROCESS | 2677 | 13:08:38 INFO - PROCESS | 2677 | [#5] imaging-gaussian-blur Cycles:10 Average:103.60 Median:87.00 stddev:19.45 (22.4%) stddev-sans-first:20.18 13:08:38 INFO - PROCESS | 2677 | Values: 92.0 87.0 113.0 87.0 82.0 131.0 124.0 92.0 96.0 132.0 13:08:38 INFO - PROCESS | 2677 | 13:08:38 INFO - PROCESS | 2677 | [#6] imaging-darkroom Cycles:10 Average:104.60 Median:96.00 stddev:19.84 (20.7%) stddev-sans-first:20.85 13:08:38 INFO - PROCESS | 2677 | Values: 97.0 156.0 122.0 96.0 95.0 95.0 97.0 95.0 96.0 97.0 13:08:38 INFO - PROCESS | 2677 | 13:08:38 INFO - PROCESS | 2677 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:93.00 stddev:6.46 (7.0%) stddev-sans-first:6.76 13:08:38 INFO - PROCESS | 2677 | Values: 93.0 95.0 93.0 93.0 110.0 92.0 92.0 94.0 92.0 106.0 13:08:38 INFO - PROCESS | 2677 | 13:08:38 INFO - PROCESS | 2677 | [#8] json-parse-financial Cycles:10 Average:62.00 Median:62.00 stddev:1.83 (2.9%) stddev-sans-first:1.79 13:08:38 INFO - PROCESS | 2677 | Values: 60.0 61.0 61.0 62.0 62.0 60.0 62.0 62.0 64.0 66.0 13:08:38 INFO - PROCESS | 2677 | 13:08:38 INFO - PROCESS | 2677 | [#9] json-stringify-tinderbox Cycles:10 Average:72.40 Median:72.50 stddev:3.95 (5.4%) stddev-sans-first:3.99 13:08:38 INFO - PROCESS | 2677 | Values: 69.0 69.0 74.0 74.0 82.0 71.0 69.0 71.0 71.0 74.0 13:08:38 INFO - PROCESS | 2677 | 13:08:38 INFO - PROCESS | 2677 | [#10] stanford-crypto-aes Cycles:10 Average:90.20 Median:88.50 stddev:9.24 (10.4%) stddev-sans-first:9.76 13:08:38 INFO - PROCESS | 2677 | Values: 88.0 89.0 94.0 94.0 86.0 75.0 100.0 107.0 80.0 89.0 13:08:38 INFO - PROCESS | 2677 | 13:08:38 INFO - PROCESS | 2677 | [#11] stanford-crypto-ccm Cycles:10 Average:150.30 Median:146.00 stddev:15.42 (10.6%) stddev-sans-first:15.90 13:08:38 INFO - PROCESS | 2677 | Values: 140.0 138.0 139.0 139.0 145.0 168.0 147.0 162.0 183.0 142.0 13:08:38 INFO - PROCESS | 2677 | 13:08:38 INFO - PROCESS | 2677 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.10 Median:179.00 stddev:3.90 (2.2%) stddev-sans-first:3.87 13:08:38 INFO - PROCESS | 2677 | Values: 181.0 182.0 173.0 172.0 180.0 177.0 172.0 181.0 178.0 175.0 13:08:38 INFO - PROCESS | 2677 | 13:08:38 INFO - PROCESS | 2677 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:68.50 stddev:2.30 (3.4%) stddev-sans-first:2.20 13:08:38 INFO - PROCESS | 2677 | Values: 65.0 70.0 66.0 69.0 70.0 68.0 71.0 68.0 67.0 64.0 13:08:38 INFO - PROCESS | 2677 | -------- Summary: end -------- 13:08:38 INFO - PROCESS | 2677 | 13:08:38 INFO - TEST-INFO | 2677: exit 0 13:08:38 INFO - TEST-OK | kraken | took 61214ms 13:08:38 INFO - SUITE-END | took 1177s 13:08:39 INFO - Completed test suite (00:19:37) 13:08:39 INFO - javascript benchmark 13:08:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7315.688129287368, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2821.7037211092834, 3274.0832566881268, 3282.5240340150663, 3318.0875259303702, 3320.4521253993084, 4846.34574332465, 5316.415194328621, 5513.669179849212, 5526.115821468566, 5577.69322687252, 4641.327007583898, 5505.476979686923, 5519.199716041172, 5537.861553461165, 5638.956792993289, 5113.156329205676, 5139.6659217150855, 5139.768710408022, 5140.640155189139, 5208.114620514521, 5086.084504789136, 5105.872353191163, 5160.483951604829, 5189.195674670432, 5261.394939581959, 5195.376554813409, 5198.584113270929, 5204.3234379530795, 5219.425863155069, 5251.448597897223, 4207.495100587918, 4376.146651402978, 5061.164907790247, 5108.080545501808, 5116.76974536143, 4184.560621134798, 5015.072211640858, 5092.6435149539175, 5144.022635699205, 5185.61107916904, 4771.642126840501, 4833.275008748681, 5450.400455949843, 5547.55619550439, 5558.6942718150485, 6097.57316987811, 6175.59858609189, 6182.010878259457, 6187.412195841388, 6195.31851496335, 6101.3079194897555, 6111.144439778434, 6136.447719705203, 6143.634700640241, 6155.384461553854, 5028.5977121830165, 5434.0, 5693.975084484791, 5724.16999535065, 5747.453991870766, 6222.160008398899, 6257.68711564429, 6276.372362763778, 6293.685315734287, 6299.181106456132, 5158.871028224325, 5981.252343457068, 6061.181740465069, 6061.969690151521, 6075.878482430327, 6110.346130329488, 6115.909724157069, 6121.788327166048, 6143.112737013686, 6265.498760099181, 5995.220621319288, 6052.061930400795, 6069.848253793691, 6167.691615419211, 6198.783042593578, 4919.827806026843, 6097.451229389288, 6107.431569637723, 6122.2761798032625, 6175.2898416681755, 4877.780499877514, 4910.361652985161, 4912.410510738734, 4925.039617274597, 4935.259711043373, 4214.852480163179, 4290.742555446684, 4296.162248361602, 4323.329883868006, 4346.9347959780625, 4797.280407938837, 5676.829695109153, 5699.971500142473, 5710.143478478261, 5716.628419152742, 6208.782692605737, 6212.347703491158, 6229.626222426669, 6263.749450022039, 6279.0, 5533.363663178706, 5582.469665381864, 5587.55299576041, 5665.971670141623, 5709.743061562157, 4477.171723231213, 5299.4435584263865, 5303.28405665238, 5308.708021058879, 5323.733813309319, 5584.7207639617045, 6255.906161407674, 6309.62142271456, 6310.085037669604, 6333.588316759488, 6145.692715364304, 6197.380261973766, 6207.162033125651, 6211.440970312694, 6227.097070924781, 6168.629882207082, 6252.218472690914, 6264.404881536247, 6279.717412716347, 6291.748330066746, 6134.294556126102, 6146.647737497922, 6175.96912015455, 6177.444030037318, 6204.968975155276, 6089.238845144357, 6148.1085242640465, 6183.196184495987, 6222.595531290452, 6242.968785156045, 4409.382686423967, 5847.8245652630485, 5886.146508756121, 6041.78853740117, 6107.236595425572, 5940.554458415722, 5951.345352011362, 5980.671063091398, 6050.576459647782, 6083.422074902877, 5654.971725141348, 5759.827205183851, 5779.739911703899, 5790.971045144747, 5851.941480585139, 5662.320521537442, 5983.042713165873, 6020.036794112921, 6066.545009124245, 6086.756529738761, 5672.943270567406, 5734.827955161351, 5831.591788574759, 5851.678157701367, 5857.209276747584], "value": 5539.972623227689, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [420.98737037888867, 438.66442171738606, 505.063107934781, 509.93370861787963, 514.1259858240988, 35083.47374789377, 42591.36112958308, 42704.35943460851, 42718.35922461162, 44482.0, 43790.56209437905, 43795.0, 43892.56107438925, 43909.56090439095, 44324.113517729704, 9218.953905230464, 9392.154706076451, 9458.716238512821, 10690.786184276349, 11058.391788451632, 10908.454577271144, 11029.83455248172, 11033.117350611972, 11041.83437248442, 11056.281341712804, 10958.616448424307, 10991.120710343153, 11001.22991390599, 11028.117750579975, 11034.282771619859, 10934.945325273362, 10945.56217751289, 10994.0, 11004.614838480615, 11023.83464248029, 10761.784764304748, 10769.299995500267, 10798.892011079868, 10803.621873234477, 10858.782824343469, 37290.0, 37763.81118094392, 37792.62207377919, 37822.4326635098, 37846.621533784586, 2946.395988822286, 3414.400860823553, 3943.132510847609, 3979.56224815273, 4019.698522610816, 28141.57787633187, 28569.714302857123, 28966.42067158666, 29004.564931526045, 29229.853850730822, 3035.605371301717, 3069.554914537402, 3115.672854350283, 3225.951610725841, 3254.9511757323658, 331214.0, 353985.99999999744, 421352.0, 422515.0, 422617.88691056654, 49730.756731082016, 54280.18579721228, 57016.71491642515, 57073.14390284149, 57268.427315727145, 58882.70558647265, 59313.81372372528, 59330.40669593335, 59672.10491842626, 60177.398226017176, 15215.31531081104, 15344.693106137815, 15516.0, 15522.991005584601, 15525.45660901863, 10757.677269681923, 11045.061169800496, 11905.523779048914, 12180.025597952319, 12198.39008049594, 14930.850691492946, 17821.287148513915, 18253.361132360304, 18319.908400457913, 18433.81566184321, 6494.447971922439, 6579.868402631921, 7830.138684744674, 7852.882206766903, 7933.603319833986, 827.3753316246195, 866.5797088412115, 876.2114097312342, 876.8377850097752, 903.0969030969031, 30221.546676799866, 30345.24136896551, 30382.696173037988, 30696.07911762651, 30786.692133078832, 1033.8811036730872, 1068.4871261794226, 1106.4301884529473, 1116.6929094499078, 1191.2316555821446, 12822.551210707581, 15615.453459129103, 15667.921660391854, 15811.367545298059, 15973.361065557248, 607861.0, 614831.0, 619652.0, 621402.0, 622463.0, 61422.85771422822, 61437.69281153655, 61890.0, 62382.37617623766, 62399.0, 1417.3692706745398, 1446.768517037269, 1458.9124652520882, 1466.7579849324954, 1477.2244571599997, 28309.0, 28649.71350286554, 29631.555526667547, 29779.255518612208, 30487.579301001675, 51872.0, 52084.69788255324, 52519.21221181762, 52560.47439525556, 52562.0, 586907.0, 587763.0, 588087.0, 588168.0, 593277.0, 22147.335579932627, 24870.005199791805, 25204.369890752878, 25504.107356242443, 25530.872345638152, 34940.65059349374, 43066.78466607647, 43912.68261952147, 44048.779756101016, 45134.774326129475, 35131.824340878135, 35361.64638353686, 35936.0, 36351.63648363482, 36578.634213657526, 35116.29767404586, 35629.109272267364, 35792.64207357893, 36694.44958325574, 36738.0, 36077.639223607424, 36250.27499450049, 36287.0, 36538.0, 36630.8168459156, 25824.612630810178, 30213.0, 31880.0, 31926.84036579895, 31943.722251110627, 23754.17021976827, 24015.399615009763, 24148.034078636658, 24493.38766530851, 24520.0], "value": 19658.492137582107, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [379.99050023749385, 384.5615997762551, 395.4404517607585, 396.51385810965246, 419.7817135089753, 16718.331266749316, 19905.0, 20740.859252741095, 21125.471863203427, 21147.0, 17748.467545973643, 18498.815011849878, 21561.13755449784, 22042.88978555109, 22311.107555697792, 5415.756290966916, 5843.2403787507565, 5887.587868849182, 5912.763489460416, 5913.793017244398, 5632.507385542814, 5788.160716696077, 5864.296284445851, 5875.206847075633, 5901.852453688649, 5724.855028994197, 5776.711164441782, 5778.82663520093, 5780.0, 5782.421757824205, 5784.2769653793275, 5786.98727722649, 5795.507381872525, 6008.24896887889, 7677.2322767723335, 7550.5469671819865, 7561.281678240558, 7649.579273139975, 7656.0, 7667.501612395176, 29250.0, 29335.2666183345, 29855.25361865949, 29928.70071299281, 29965.55051674205, 2840.9857950710116, 2947.6904924982996, 2950.5574163875376, 2954.3500429905384, 3004.0987703688807, 16377.344906203738, 17066.317347306216, 17072.06103664298, 17121.22954467052, 17393.739093913602, 1695.6345897472956, 1923.9551275687566, 1943.5626983928644, 1965.8401543089503, 2052.158614967871, 163078.18460907738, 171305.0, 171992.0, 173944.0, 174242.0, 18982.810171898105, 22870.313890583308, 23057.769422305897, 23251.18620848296, 23519.88240058789, 12096.75806483883, 12726.109172357847, 31693.841530792197, 40536.79731601382, 40929.38605920914, 6282.1519094921605, 6466.0, 7538.924610753932, 8231.218034286852, 8337.458065225741, 6955.826104347432, 8277.793055173668, 8395.832083358298, 8430.620622072021, 8567.528785916835, 3598.208394153282, 3608.4767708682093, 3758.962410375916, 4103.85636502721, 4169.0, 1774.7071733164141, 1848.9815101849078, 1996.7004949257728, 2020.7170996060563, 2063.8245749111493, 972.9027097290215, 994.2841154368842, 1007.4106647611229, 1011.6610935336597, 1063.7340664833791, 21406.678899816514, 21913.342599722033, 22032.33902982913, 22036.669449958263, 22152.563218046, 951.2342564235856, 996.6893535001594, 1047.4436202518982, 1056.6037735849056, 1059.6238335390979, 11446.198766086294, 11523.0, 11530.308181509135, 11588.304701717923, 11905.642830715093, 543074.0, 586928.0, 723884.0, 728226.0, 739231.0, 90770.0, 143475.0, 152521.23739381233, 153021.0, 158264.20867895818, 986.3933680786265, 999.975025598767, 1006.2754816532085, 1007.0734923870057, 1021.4280003198085, 18775.624487510446, 19466.416007519798, 19528.31650892212, 19529.8047019528, 19549.609007820047, 57046.7147664259, 58668.70665646644, 61789.691051544454, 63840.72318553696, 63995.6800215996, 86877.0, 87548.0, 94012.0, 95289.5235523818, 95859.0, 8855.690050848189, 12745.61763147107, 13209.801852972405, 13370.532031378854, 13426.932865335611, 14042.438302468196, 14149.151050936976, 14306.856931430968, 14567.251929768496, 14729.26353682333, 11640.24338418034, 11746.823797642872, 11861.703457413634, 12051.33717645538, 12117.333546655018, 8089.312408445113, 8132.634031468717, 11674.357910315015, 11983.981361584363, 12042.21725587834, 8015.358771298399, 8254.669813207405, 8344.83310333802, 8569.614367353359, 8600.483970961763, 12799.872001279868, 13152.605421837361, 13387.330633468482, 13513.121647092907, 13556.186628802303, 11835.993940515153, 11895.643130706092, 12064.819027714415, 12197.634070977885, 12209.38953052326], "value": 10790.08650250631, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1431.2342896550347, 1436.3105709259548, 1454.6217983324336, 1465.0550394995228, 1467.053750331036, 7411.370033547141, 7655.0, 7925.682972681093, 8341.791455213615, 8367.079621241659, 7879.724209652663, 8115.553644549547, 8133.75598732039, 8210.261076503113, 8214.466059706116, 2252.3805953362794, 2299.896504657286, 2306.2274138163734, 2314.9768502315014, 2315.525317309956, 2302.3208153594646, 2334.26470661741, 2337.240396871015, 2340.110757911991, 2352.717673879137, 2256.1313894150708, 2261.061659411342, 2270.9545809083806, 2276.5446910617943, 2280.8403411761183, 2107.8617546524856, 2253.5154941687533, 2273.2498275569105, 2273.3407311879537, 2281.4372155073743, 2057.6193404220267, 2307.8384513084093, 2327.790498855094, 2333.428310064028, 2336.883155842218, 8123.147069557729, 8193.877091843628, 8195.139510351446, 8197.877031844528, 8231.753047408587, 4988.251762235657, 5111.923321150186, 5130.333056702642, 5141.74291285438, 5161.561267292284, 3101.147184524274, 3222.96777032229, 3331.1838599543025, 3380.138064793462, 3494.318607871466, 1098.3903933317006, 1106.5684383090602, 1160.7156246719524, 1161.1233518693332, 1239.1016513028073, 10503.894961050368, 10528.0, 10539.314944528658, 10594.31136976094, 10639.521221545048, 3726.6459686329754, 3871.10964478166, 4575.931361029588, 4683.695559788603, 4699.436067671902, 9323.533823308808, 9368.063193680577, 9377.812443751087, 9382.812343753223, 9408.059194080537, 5136.897262054738, 5184.766685499161, 5188.766505507186, 5189.896202075937, 5197.376314842243, 4147.357159640261, 4262.488501379854, 4367.798855314813, 4647.442306923191, 4705.011947490997, 3289.3256882339065, 3748.1379282765115, 3840.6735427488975, 3887.7667339959694, 3901.356276214393, 1244.3156264054733, 1256.221142891395, 1259.6976725585976, 1260.571405722059, 1263.1915574032625, 841.2302742990096, 849.6516428264382, 865.2256230673512, 890.7060669978891, 900.7342833863895, 5487.835364939058, 5523.061079616475, 5604.243427137366, 5782.508486778587, 5846.356900740915, 947.3321308477507, 976.6532880827347, 1016.1413605503337, 1019.23557332001, 1037.527924794217, 3701.833417496219, 3753.8686145985307, 3816.7709937403843, 3869.3035253654048, 3879.0, 9696.660616878375, 9858.260630452745, 9984.20126389887, 9996.550155243032, 9996.900030999743, 9910.653127140515, 9938.751531211632, 9961.402315860927, 9966.900330996597, 9981.401115933068, 6679.131712877295, 7685.346745526581, 7785.610719464004, 7925.920740792633, 7927.722529711547, 4851.80592776285, 5308.964751873347, 5591.552675785846, 5684.77260909559, 5753.626014309057, 8772.254358379354, 8991.28069754405, 9024.278057755233, 9123.361364704408, 9284.071592840932, 9102.772430689021, 9309.767255818388, 9339.439633622005, 9392.95303523478, 9396.06039396055, 6853.588784672936, 7002.509824312249, 7058.082449281561, 7165.928340716526, 7250.637468126467, 7789.260020298063, 7954.522728636069, 7956.323712484504, 7967.362610991223, 8004.159563245776, 6693.966530167513, 6783.219929708147, 7079.242062645331, 7105.715771369088, 7277.199508054004, 6886.208086069965, 6947.826304342229, 6986.0, 7057.752978645723, 7076.752313668997, 6328.430441260309, 6354.904676429765, 6411.102445657705, 6414.069959855888, 6432.067350234283, 4989.376327959005, 5048.368953880765, 5074.416442109205, 5098.923516147187, 5125.769340379767, 4920.803167873245, 4962.181240095344, 5121.743912804271, 5147.305113809588, 5190.6107041971245], "value": 4378.173978095123, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [318.94259033373993, 349.93701133795923, 350.87369543764515, 365.3496775739184, 374.7021118211022, 4686.531346865312, 4927.201571426431, 5293.867653308669, 5383.084875571152, 5406.864828379293, 4818.386210342243, 5140.614453915952, 5245.947540524594, 5290.7354632268425, 5319.468053194679, 4111.280525907954, 4162.542120366765, 4175.478065241829, 4177.415161877339, 4183.51081106741, 3617.0053235360224, 4027.6173763492566, 4160.854370097048, 4174.248635245654, 4212.1154557542795, 3575.803330816804, 4127.566605506424, 4139.668826493888, 4146.357314616239, 4171.10321280926, 3613.1147868772055, 3795.6394142556414, 3810.1427178884805, 4149.555868629046, 4156.459660244149, 3312.320974200283, 3698.9630103699155, 3712.6472985066375, 3715.4612581175847, 3721.348763966295, 3991.7604943703473, 5012.498750124958, 5134.255532947739, 5153.896922061575, 5265.973670131625, 4178.827009954806, 4629.56947602508, 4784.545468180552, 4807.735574543399, 4821.662483626147, 5531.806386776484, 5609.0, 5624.409437009096, 5640.435956404327, 5654.264945557051, 3494.0391392367046, 3500.8949731508096, 3762.777097443342, 4042.393640953851, 4046.5953404659595, 4705.435347758256, 4841.394825646794, 4846.418429788448, 5313.123334649778, 6108.450239478469, 4106.445629839993, 4126.855560055444, 4157.771322577227, 4179.561146079679, 4195.517515485697, 3457.6888080072913, 3613.9638603614153, 3944.6055394460323, 4115.464989551339, 4224.429701990253, 4774.259989701602, 4776.593989510861, 4778.283257511332, 4789.209780386267, 4809.0, 4697.553732395417, 5072.771725272371, 5396.75874548856, 5585.057224356393, 5676.801311954062, 1147.913906457019, 1210.5460452330376, 1274.7634794249564, 1293.379177994549, 1360.4354193009988, 860.2816648098783, 901.5620085962879, 955.5222388805597, 972.7324985628867, 981.6711401680374, 4597.0, 4645.419322584677, 4649.814007439732, 4657.371254880615, 5079.212722028092, 4563.680542362003, 5056.0, 5167.431582525919, 5615.494605485526, 5630.986422444, 4084.469019027567, 4307.892302692458, 4457.710248833815, 4951.8266860659705, 5007.774650140753, 2627.4745050989877, 2717.4972630063503, 2898.768023590008, 2909.0, 2909.2435966648823, 5108.029474399927, 5495.2856128703015, 5530.668159910419, 5640.435956404327, 5825.766699481828, 4689.882752931204, 4849.387206531086, 5445.264889239902, 5737.51231145349, 5891.440313170242, 4677.391939047902, 4963.503649635152, 5163.509466600742, 5207.921881171786, 5703.486686198262, 5443.374011988672, 5497.725113744376, 5501.642393244426, 5518.868631930364, 5539.701024074964, 4793.328933949319, 4831.212451393007, 5118.283440318284, 5474.084070575426, 5575.961101199775, 4827.758612069312, 5080.974595127001, 5264.815731449381, 5265.52610265078, 5597.780667876604, 3882.9223415532097, 3886.417037444406, 3906.9609303907732, 3950.664193543581, 3955.268275369066, 4669.392978912855, 4980.676256043345, 5082.974585127198, 5173.767180476812, 5501.504864562208, 4624.722516649012, 4798.880027999188, 4958.801647934187, 5173.0, 5208.5312321891215, 4726.71639701619, 5045.697258164522, 5159.170137744325, 5313.893722125613, 5628.071368224197, 4842.346283251716, 5512.944870551403, 5523.061079616556, 5530.668159910419, 5604.719764011702, 4413.933790993202, 5244.842654720364, 5683.9715801420725, 5695.316562012585, 5702.743376548148, 4699.718016918996, 4884.8290309838985, 5344.114178343651, 5388.0, 5557.3331200256225], "value": 4022.162718999544, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [655.9836004099897, 723.1358526560762, 734.3097488360944, 793.1037927142328, 818.9569700575055, 14524.63688407789, 15491.535253942386, 16625.418110366125, 17516.386926457577, 17551.82448175518, 16486.587835304123, 16502.504924852274, 16523.0, 16569.17154142291, 16652.75020874688, 690.3510699942063, 868.9956550217256, 897.6364572348177, 898.8786513820615, 904.1997831918767, 713.6289129652604, 858.3347905373323, 882.9117088291184, 897.7979954510248, 897.9730608081735, 778.6457161991309, 937.2408349237139, 940.8917974432925, 944.8441007233798, 945.2674177512414, 929.972100836976, 939.3893968920256, 939.6194541210821, 941.0683423410842, 943.4056544377067, 682.5597489619217, 693.7225109956007, 699.6117154978984, 705.3546005405049, 707.7841258416181, 15094.094354338775, 15447.691046179014, 15452.768208476882, 15530.145841978687, 15632.2183890805, 11622.41040150236, 13501.59495215145, 13741.725165496635, 14031.298435078204, 14373.425062997467, 11616.494104973357, 11769.823452648217, 11787.823182652268, 11796.35120068396, 11892.286462812259, 3686.4654625079484, 3719.2189640175325, 3758.699304055669, 3794.6015668354703, 3818.179091495314, 109750.0, 110938.0, 110995.56537694305, 111457.44271278592, 112329.43835280853, 10735.033846953655, 10791.6222932197, 10805.297655652357, 10835.458227088615, 11144.33134011962, 21651.35045948624, 21751.782482174975, 22192.223272185394, 22269.66595501069, 22291.331260062223, 7637.809054773564, 7667.194944530744, 7716.498427602188, 7737.767866964, 7788.221177882279, 4328.935065974013, 4348.543402942709, 4350.477942646839, 4426.889327766831, 4498.865034048984, 2767.266674331304, 3138.8587513561943, 3145.8360406649686, 3303.702666760003, 3930.292547341449, 624.2166081567603, 685.2736099734298, 717.8026042838156, 734.3794493652855, 740.9184989651134, 519.5376115257424, 662.6123717625147, 671.9596824190564, 686.4062585863193, 696.7282759723712, 9971.762968580108, 10143.797124057477, 10267.332623379456, 10484.263183491877, 10559.683209503728, 668.8528523724773, 703.665758764593, 705.5660768627359, 710.7761055267574, 731.9377852882565, 4791.401074865642, 4968.428630707443, 4987.975060124676, 5022.146235140035, 5037.4458809530925, 90453.54773226092, 106795.0, 106802.0, 109209.0, 110258.0, 41976.370354444705, 66208.0, 93506.0, 93791.0, 94805.0, 78342.6082869582, 81066.78399824008, 81644.18355816366, 82445.58777206075, 83881.0, 7703.460757747128, 9671.742673452407, 9839.884424848691, 9874.605015799287, 9935.155511781579, 49431.0, 51075.97848042944, 52155.73922130365, 52158.0, 53153.7342313286, 58169.0, 70023.0, 71487.64256178893, 72298.91551626835, 73455.63272183605, 9772.778402699663, 11369.715757106138, 11513.481893314989, 11574.247673901169, 12026.939865300617, 12762.61712148637, 12765.680857978625, 12952.740945181233, 13344.266065366499, 13703.520376787163, 11907.82138267944, 12167.75664486723, 12226.572069977508, 12272.325022123869, 12574.748505030031, 10109.292349535463, 11960.890228008338, 12135.878641213474, 12193.817092743793, 12223.877761222275, 12022.879771202175, 12064.698382540155, 12066.818997714865, 12075.990476285031, 12158.331291779037, 8714.956425217833, 9525.476098814355, 9576.76058098553, 9693.806123877624, 10105.242106842163, 8741.519216443157, 9788.00113224974, 9909.950450247703, 10044.748881278027, 10075.546600403146], "value": 7407.0514922541115, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1559.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 118.0, 117.0, 118.0, 118.0, 119.0, 120.0, 170.0, 166.0, 119.0], "value": 127.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 144.0, 103.0, 186.0, 149.0, 111.0, 130.0, 149.0, 123.0, 133.0], "value": 140.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [205.0, 242.0, 277.0, 216.0, 200.0, 200.0, 196.0, 197.0, 252.0, 278.0], "value": 226.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 59.0, 59.0, 86.0, 61.0, 58.0, 60.0, 57.0, 75.0, 70.0], "value": 66.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 70.0, 82.0, 72.0, 69.0, 70.0, 79.0, 71.0, 71.0, 82.0], "value": 75.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 87.0, 113.0, 87.0, 82.0, 131.0, 124.0, 92.0, 96.0, 132.0], "value": 103.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 156.0, 122.0, 96.0, 95.0, 95.0, 97.0, 95.0, 96.0, 97.0], "value": 104.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 95.0, 93.0, 93.0, 110.0, 92.0, 92.0, 94.0, 92.0, 106.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 61.0, 62.0, 62.0, 60.0, 62.0, 62.0, 64.0, 66.0], "value": 62.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 74.0, 74.0, 82.0, 71.0, 69.0, 71.0, 71.0, 74.0], "value": 72.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 89.0, 94.0, 94.0, 86.0, 75.0, 100.0, 107.0, 80.0, 89.0], "value": 90.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 138.0, 139.0, 139.0, 145.0, 168.0, 147.0, 162.0, 183.0, 142.0], "value": 150.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 182.0, 173.0, 172.0, 180.0, 177.0, 172.0, 181.0, 178.0, 175.0], "value": 177.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 70.0, 66.0, 69.0, 70.0, 68.0, 71.0, 68.0, 67.0, 64.0], "value": 67.8, "unit": "score"}]}]} 13:08:39 INFO - Return code: 0 13:08:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:08:39 ERROR - # TBPL SUCCESS # 13:08:39 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:08:39 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:08:39 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:08:39 INFO - 2017-01-19 13:08:39.400 screenresolution[2687:26118] starting screenresolution argv=screenresolution get 13:08:39 INFO - 2017-01-19 13:08:39.402 screenresolution[2687:26118] Display 0: 1600x1200x32@60 13:08:39 INFO - 2017-01-19 13:08:39.408 screenresolution[2688:26121] starting screenresolution argv=screenresolution list 13:08:39 INFO - Available Modes on Display 0 13:08:39 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:08:39 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:08:39 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:08:39 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:08:39 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:08:39 INFO - Intel Iris: 13:08:39 INFO - Chipset Model: Intel Iris 13:08:39 INFO - Type: GPU 13:08:39 INFO - Bus: Built-In 13:08:39 INFO - VRAM (Dynamic, Max): 1536 MB 13:08:39 INFO - Vendor: Intel (0x8086) 13:08:39 INFO - Device ID: 0x0a2e 13:08:39 INFO - Revision ID: 0x0009 13:08:39 INFO - Displays: 13:08:39 INFO - Display: 13:08:39 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:08:39 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:08:39 INFO - Display Serial Number: 1600x1200 60 13:08:39 INFO - Main Display: Yes 13:08:39 INFO - Mirror: Off 13:08:39 INFO - Online: Yes 13:08:39 INFO - Rotation: Supported 13:08:39 INFO - Return code: 0 13:08:39 INFO - Running post-action listener: _resource_record_post_action 13:08:39 INFO - [mozharness: 2017-01-19 21:08:39.645727Z] Finished run-tests step (success) 13:08:39 INFO - Running post-run listener: _resource_record_post_run 13:08:39 INFO - Total resource usage - Wall time: 1200s; CPU: 55.0%; Read bytes: 245760; Write bytes: 556966912; Read time: 6; Write time: 1723 13:08:39 INFO - TinderboxPrint: CPU usage
54.5% 13:08:39 INFO - TinderboxPrint: I/O read bytes / time
245,760 / 6 13:08:39 INFO - TinderboxPrint: I/O write bytes / time
556,966,912 / 1,723 13:08:39 INFO - TinderboxPrint: CPU idle
2,183.7 (45.5%) 13:08:39 INFO - TinderboxPrint: CPU system
971.9 (20.2%) 13:08:39 INFO - TinderboxPrint: CPU user
1,646.0 (34.3%) 13:08:39 INFO - TinderboxPrint: Swap in / out
250,363,904 / 0 13:08:39 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 242641408; Write bytes: 236338176; Read time: 17563; Write time: 511 13:08:39 INFO - run-tests - Wall time: 1179s; CPU: 55.0%; Read bytes: 245760; Write bytes: 303106048; Read time: 6; Write time: 1159 13:08:40 INFO - Running post-run listener: _upload_blobber_files 13:08:40 INFO - Blob upload gear active. 13:08:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:08:40 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 13:08:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:08:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:08:40 INFO - (blobuploader) - INFO - Open directory for files ... 13:08:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:08:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:08:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:08:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:08:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:08:41 INFO - (blobuploader) - INFO - Done attempting. 13:08:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:08:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:08:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:08:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:08:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:08:42 INFO - (blobuploader) - INFO - Done attempting. 13:08:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 13:08:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:08:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:08:43 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 13:08:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:08:43 INFO - (blobuploader) - INFO - Done attempting. 13:08:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:08:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:08:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:08:45 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:08:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:08:45 INFO - (blobuploader) - INFO - Done attempting. 13:08:45 INFO - (blobuploader) - INFO - Iteration through files over. 13:08:45 INFO - Return code: 0 13:08:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:08:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:08:45 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5cb1ddba86b2e9905457ae20389e49364c41e25a5f03c87379a060468282ec00983d4abfb2e86b6f33801b414cdbe0b63465bbc95ae2d516c7028bcb5a97fdd1", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/78bc35a72c5e57484219b7b51816f677c92c1ed5362728141ad395cdb9f5ce1f954bcf62de5b6c1a6f10cfd8a3c3906b5c3a0acbb1cb705b87094b9dee5bef46", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4c174c9078b1a7e52062e80f52b4417cda71bc11ce11eca50a98799e2412bae4258a036debfe4196a9b323a4a20d0c0c9a2a849da57005643a2f5aa3481b1ee4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bf7b6712ab23cc031113e2899b2acfb75a6bef904ff95343953a7175769da6e03eef8a241138794cddc4eb0a155e6af3ea74cbb8ab05782f1f1dbbaec1473742"} 13:08:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:08:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:08:45 INFO - Contents: 13:08:45 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5cb1ddba86b2e9905457ae20389e49364c41e25a5f03c87379a060468282ec00983d4abfb2e86b6f33801b414cdbe0b63465bbc95ae2d516c7028bcb5a97fdd1", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/78bc35a72c5e57484219b7b51816f677c92c1ed5362728141ad395cdb9f5ce1f954bcf62de5b6c1a6f10cfd8a3c3906b5c3a0acbb1cb705b87094b9dee5bef46", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4c174c9078b1a7e52062e80f52b4417cda71bc11ce11eca50a98799e2412bae4258a036debfe4196a9b323a4a20d0c0c9a2a849da57005643a2f5aa3481b1ee4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bf7b6712ab23cc031113e2899b2acfb75a6bef904ff95343953a7175769da6e03eef8a241138794cddc4eb0a155e6af3ea74cbb8ab05782f1f1dbbaec1473742"} 13:08:45 INFO - Running post-run listener: copy_logs_to_upload_dir 13:08:45 INFO - Copying logs to upload dir... 13:08:45 INFO - mkdir: /builds/slave/test/build/upload/logs 13:08:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.047085 ========= master_lag: 1.61 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2017-01-19 13:08:47.616604) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-19 13:08:47.620181) ========= 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.jPzWAUIsxF/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.F7XSBgcGmV/Listeners TMPDIR=/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5cb1ddba86b2e9905457ae20389e49364c41e25a5f03c87379a060468282ec00983d4abfb2e86b6f33801b414cdbe0b63465bbc95ae2d516c7028bcb5a97fdd1", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/78bc35a72c5e57484219b7b51816f677c92c1ed5362728141ad395cdb9f5ce1f954bcf62de5b6c1a6f10cfd8a3c3906b5c3a0acbb1cb705b87094b9dee5bef46", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4c174c9078b1a7e52062e80f52b4417cda71bc11ce11eca50a98799e2412bae4258a036debfe4196a9b323a4a20d0c0c9a2a849da57005643a2f5aa3481b1ee4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bf7b6712ab23cc031113e2899b2acfb75a6bef904ff95343953a7175769da6e03eef8a241138794cddc4eb0a155e6af3ea74cbb8ab05782f1f1dbbaec1473742"} build_url:https://queue.taskcluster.net/v1/task/I5vM5wREQx6CvNpKF5tLdg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011338 build_url: 'https://queue.taskcluster.net/v1/task/I5vM5wREQx6CvNpKF5tLdg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5cb1ddba86b2e9905457ae20389e49364c41e25a5f03c87379a060468282ec00983d4abfb2e86b6f33801b414cdbe0b63465bbc95ae2d516c7028bcb5a97fdd1", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/78bc35a72c5e57484219b7b51816f677c92c1ed5362728141ad395cdb9f5ce1f954bcf62de5b6c1a6f10cfd8a3c3906b5c3a0acbb1cb705b87094b9dee5bef46", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4c174c9078b1a7e52062e80f52b4417cda71bc11ce11eca50a98799e2412bae4258a036debfe4196a9b323a4a20d0c0c9a2a849da57005643a2f5aa3481b1ee4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bf7b6712ab23cc031113e2899b2acfb75a6bef904ff95343953a7175769da6e03eef8a241138794cddc4eb0a155e6af3ea74cbb8ab05782f1f1dbbaec1473742"}' ========= master_lag: 0.04 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-19 13:08:47.667135) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 4 secs) (at 2017-01-19 13:08:47.667494) ========= 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.jPzWAUIsxF/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.F7XSBgcGmV/Listeners TMPDIR=/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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.005341 ========= master_lag: 4.32 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 4 secs) (at 2017-01-19 13:08:51.995700) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-19 13:08:51.999071) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-19 13:08:52.000715) ========= ========= Total master_lag: 6.05 =========